{"level":"warn","ts":"2026-10-14T15:37:10.104294Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-14T15:37:10.104407Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.127: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://162.253.55.127:2380","--initial-cluster=instance=https://162.253.55.127:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.127:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.127: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-10-14T15:37:10.104496Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-14T15:37:10.104511Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.127:2380"]} {"level":"info","ts":"2026-10-14T15:37:10.104536Z","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-10-14T15:37:10.105328Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.127:2379"]} {"level":"info","ts":"2026-10-14T15:37:10.105464Z","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://162.253.55.127:2380"],"listen-peer-urls":["https://162.253.55.127:2380"],"advertise-client-urls":["https://162.253.55.127:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.127:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.127: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-10-14T15:37:10.158802Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"53.090162ms"} {"level":"info","ts":"2026-10-14T15:37:10.167915Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9e5e76b85fbfd435","cluster-id":"7d97e4b11cbd31c2"} {"level":"info","ts":"2026-10-14T15:37:10.168Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9e5e76b85fbfd435 switched to configuration voters=()"} {"level":"info","ts":"2026-10-14T15:37:10.168023Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9e5e76b85fbfd435 became follower at term 0"} {"level":"info","ts":"2026-10-14T15:37:10.168038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9e5e76b85fbfd435 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-14T15:37:10.168051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9e5e76b85fbfd435 became follower at term 1"} {"level":"info","ts":"2026-10-14T15:37:10.168098Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9e5e76b85fbfd435 switched to configuration voters=(11411689040055882805)"} {"level":"warn","ts":"2026-10-14T15:37:10.175488Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-14T15:37:10.176907Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-14T15:37:10.17847Z","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-10-14T15:37:10.180943Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9e5e76b85fbfd435","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-14T15:37:10.181166Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9e5e76b85fbfd435","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-14T15:37:10.181569Z","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-10-14T15:37:10.181729Z","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-10-14T15:37:10.181761Z","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-10-14T15:37:10.184041Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9e5e76b85fbfd435 switched to configuration voters=(11411689040055882805)"} {"level":"info","ts":"2026-10-14T15:37:10.184158Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"7d97e4b11cbd31c2","local-member-id":"9e5e76b85fbfd435","added-peer-id":"9e5e76b85fbfd435","added-peer-peer-urls":["https://162.253.55.127:2380"]} {"level":"info","ts":"2026-10-14T15:37:10.187006Z","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-10-14T15:37:10.187234Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9e5e76b85fbfd435","initial-advertise-peer-urls":["https://162.253.55.127:2380"],"listen-peer-urls":["https://162.253.55.127:2380"],"advertise-client-urls":["https://162.253.55.127:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.127:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-14T15:37:10.187271Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-14T15:37:10.187483Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.127:2380"} {"level":"info","ts":"2026-10-14T15:37:10.187544Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.127:2380"} {"level":"info","ts":"2026-10-14T15:37:10.369073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9e5e76b85fbfd435 is starting a new election at term 1"} {"level":"info","ts":"2026-10-14T15:37:10.36913Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9e5e76b85fbfd435 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-14T15:37:10.36915Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9e5e76b85fbfd435 received MsgPreVoteResp from 9e5e76b85fbfd435 at term 1"} {"level":"info","ts":"2026-10-14T15:37:10.369345Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9e5e76b85fbfd435 became candidate at term 2"} {"level":"info","ts":"2026-10-14T15:37:10.369455Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9e5e76b85fbfd435 received MsgVoteResp from 9e5e76b85fbfd435 at term 2"} {"level":"info","ts":"2026-10-14T15:37:10.369534Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9e5e76b85fbfd435 became leader at term 2"} {"level":"info","ts":"2026-10-14T15:37:10.36961Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9e5e76b85fbfd435 elected leader 9e5e76b85fbfd435 at term 2"} {"level":"info","ts":"2026-10-14T15:37:10.377421Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T15:37:10.38554Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9e5e76b85fbfd435","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.127:2379]}","request-path":"/0/members/9e5e76b85fbfd435/attributes","cluster-id":"7d97e4b11cbd31c2","publish-timeout":"7s"} {"level":"info","ts":"2026-10-14T15:37:10.38553Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-14T15:37:10.385652Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-14T15:37:10.387236Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.127:2379"} {"level":"info","ts":"2026-10-14T15:37:10.387359Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-14T15:37:10.387375Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-14T15:37:10.38788Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"7d97e4b11cbd31c2","local-member-id":"9e5e76b85fbfd435","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T15:37:10.387935Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-14T15:37:10.388058Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T15:37:10.388093Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T15:37:19.660373Z","caller":"traceutil/trace.go:171","msg":"trace[698825634] linearizableReadLoop","detail":"{readStateIndex:351; appliedIndex:350; }","duration":"105.808795ms","start":"2026-10-14T15:37:19.554527Z","end":"2026-10-14T15:37:19.660336Z","steps":["trace[698825634] 'read index received' (duration: 93.831224ms)","trace[698825634] 'applied index is now lower than readState.Index' (duration: 11.976301ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:37:19.660515Z","caller":"traceutil/trace.go:171","msg":"trace[452162671] transaction","detail":"{read_only:false; response_revision:341; number_of_response:1; }","duration":"146.401281ms","start":"2026-10-14T15:37:19.514074Z","end":"2026-10-14T15:37:19.660476Z","steps":["trace[452162671] 'process raft request' (duration: 134.345487ms)","trace[452162671] 'compare' (duration: 11.693913ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T15:37:19.660832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.187825ms","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-10-14T15:37:19.660979Z","caller":"traceutil/trace.go:171","msg":"trace[1189485150] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:341; }","duration":"106.527225ms","start":"2026-10-14T15:37:19.55443Z","end":"2026-10-14T15:37:19.660957Z","steps":["trace[1189485150] 'agreement among raft nodes before linearized reading' (duration: 106.084432ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:37:19.661036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.758836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-10-14T15:37:19.661176Z","caller":"traceutil/trace.go:171","msg":"trace[1851494912] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:341; }","duration":"103.971793ms","start":"2026-10-14T15:37:19.557163Z","end":"2026-10-14T15:37:19.661135Z","steps":["trace[1851494912] 'agreement among raft nodes before linearized reading' (duration: 103.738706ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:37:19.932646Z","caller":"traceutil/trace.go:171","msg":"trace[1803687233] linearizableReadLoop","detail":"{readStateIndex:359; appliedIndex:354; }","duration":"223.90312ms","start":"2026-10-14T15:37:19.708692Z","end":"2026-10-14T15:37:19.932595Z","steps":["trace[1803687233] 'read index received' (duration: 11.198ms)","trace[1803687233] 'applied index is now lower than readState.Index' (duration: 212.70409ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:37:19.932795Z","caller":"traceutil/trace.go:171","msg":"trace[1807880104] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"243.884239ms","start":"2026-10-14T15:37:19.688843Z","end":"2026-10-14T15:37:19.932727Z","steps":["trace[1807880104] 'process raft request' (duration: 162.279323ms)","trace[1807880104] 'compare' (duration: 81.309067ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T15:37:19.933013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.296401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-10-14T15:37:19.933122Z","caller":"traceutil/trace.go:171","msg":"trace[305448882] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:349; }","duration":"224.459825ms","start":"2026-10-14T15:37:19.708633Z","end":"2026-10-14T15:37:19.933093Z","steps":["trace[305448882] 'agreement among raft nodes before linearized reading' (duration: 224.121686ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:37:19.952308Z","caller":"traceutil/trace.go:171","msg":"trace[621883591] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"224.849367ms","start":"2026-10-14T15:37:19.727432Z","end":"2026-10-14T15:37:19.952281Z","steps":["trace[621883591] 'process raft request' (duration: 224.635871ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:37:19.95254Z","caller":"traceutil/trace.go:171","msg":"trace[2063079540] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"221.619124ms","start":"2026-10-14T15:37:19.730878Z","end":"2026-10-14T15:37:19.952497Z","steps":["trace[2063079540] 'process raft request' (duration: 221.300645ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:37:19.952863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.230204ms","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-10-14T15:37:19.952915Z","caller":"traceutil/trace.go:171","msg":"trace[2000751720] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:352; }","duration":"194.329847ms","start":"2026-10-14T15:37:19.758573Z","end":"2026-10-14T15:37:19.952902Z","steps":["trace[2000751720] 'agreement among raft nodes before linearized reading' (duration: 194.214903ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:37:19.95317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.385894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-10-14T15:37:19.953203Z","caller":"traceutil/trace.go:171","msg":"trace[1307227064] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:352; }","duration":"144.420955ms","start":"2026-10-14T15:37:19.808775Z","end":"2026-10-14T15:37:19.953196Z","steps":["trace[1307227064] 'agreement among raft nodes before linearized reading' (duration: 144.371234ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:37:19.953314Z","caller":"traceutil/trace.go:171","msg":"trace[313879260] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"220.972276ms","start":"2026-10-14T15:37:19.732334Z","end":"2026-10-14T15:37:19.953306Z","steps":["trace[313879260] 'process raft request' (duration: 219.907396ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:37:20.134959Z","caller":"traceutil/trace.go:171","msg":"trace[725989011] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"176.729666ms","start":"2026-10-14T15:37:19.95816Z","end":"2026-10-14T15:37:20.134889Z","steps":["trace[725989011] 'process raft request' (duration: 153.629755ms)","trace[725989011] 'compare' (duration: 22.723741ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:37:20.135169Z","caller":"traceutil/trace.go:171","msg":"trace[358113478] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"174.021939ms","start":"2026-10-14T15:37:19.961095Z","end":"2026-10-14T15:37:20.135117Z","steps":["trace[358113478] 'process raft request' (duration: 173.738961ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:37:20.135484Z","caller":"traceutil/trace.go:171","msg":"trace[869039483] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"172.972449ms","start":"2026-10-14T15:37:19.962492Z","end":"2026-10-14T15:37:20.135465Z","steps":["trace[869039483] 'process raft request' (duration: 172.581878ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:37:20.135678Z","caller":"traceutil/trace.go:171","msg":"trace[497470751] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"173.666749ms","start":"2026-10-14T15:37:19.96199Z","end":"2026-10-14T15:37:20.135657Z","steps":["trace[497470751] 'process raft request' (duration: 172.9809ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:37:20.135709Z","caller":"traceutil/trace.go:171","msg":"trace[132330592] linearizableReadLoop","detail":"{readStateIndex:369; appliedIndex:362; }","duration":"170.685014ms","start":"2026-10-14T15:37:19.964992Z","end":"2026-10-14T15:37:20.135677Z","steps":["trace[132330592] 'read index received' (duration: 39.256167ms)","trace[132330592] 'applied index is now lower than readState.Index' (duration: 131.426197ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:37:20.135735Z","caller":"traceutil/trace.go:171","msg":"trace[2087968156] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"167.633887ms","start":"2026-10-14T15:37:19.968061Z","end":"2026-10-14T15:37:20.135695Z","steps":["trace[2087968156] 'process raft request' (duration: 167.315728ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:37:20.135684Z","caller":"traceutil/trace.go:171","msg":"trace[2004085530] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"172.534767ms","start":"2026-10-14T15:37:19.963034Z","end":"2026-10-14T15:37:20.135569Z","steps":["trace[2004085530] 'process raft request' (duration: 172.237468ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:37:20.135893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.871259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/edit\" ","response":"range_response_count:1 size:3475"} {"level":"info","ts":"2026-10-14T15:37:20.135949Z","caller":"traceutil/trace.go:171","msg":"trace[584393208] range","detail":"{range_begin:/registry/clusterroles/edit; range_end:; response_count:1; response_revision:360; }","duration":"170.976522ms","start":"2026-10-14T15:37:19.964957Z","end":"2026-10-14T15:37:20.135933Z","steps":["trace[584393208] 'agreement among raft nodes before linearized reading' (duration: 170.797367ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:37:20.345475Z","caller":"traceutil/trace.go:171","msg":"trace[1095163456] linearizableReadLoop","detail":"{readStateIndex:380; appliedIndex:379; }","duration":"120.077616ms","start":"2026-10-14T15:37:20.225344Z","end":"2026-10-14T15:37:20.345422Z","steps":["trace[1095163456] 'read index received' (duration: 107.09155ms)","trace[1095163456] 'applied index is now lower than readState.Index' (duration: 12.984516ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:37:20.34564Z","caller":"traceutil/trace.go:171","msg":"trace[348450143] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"124.141521ms","start":"2026-10-14T15:37:20.221438Z","end":"2026-10-14T15:37:20.34558Z","steps":["trace[348450143] 'process raft request' (duration: 110.97602ms)","trace[348450143] 'compare' (duration: 12.871063ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T15:37:20.345692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.325642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/kube-proxy\" ","response":"range_response_count:1 size:2901"} {"level":"info","ts":"2026-10-14T15:37:20.345816Z","caller":"traceutil/trace.go:171","msg":"trace[1857896928] range","detail":"{range_begin:/registry/daemonsets/kube-system/kube-proxy; range_end:; response_count:1; response_revision:370; }","duration":"126.516167ms","start":"2026-10-14T15:37:20.219248Z","end":"2026-10-14T15:37:20.345764Z","steps":["trace[1857896928] 'agreement among raft nodes before linearized reading' (duration: 126.304912ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:37:20.350132Z","caller":"traceutil/trace.go:171","msg":"trace[954653085] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"119.13406ms","start":"2026-10-14T15:37:20.230972Z","end":"2026-10-14T15:37:20.350106Z","steps":["trace[954653085] 'process raft request' (duration: 119.041528ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:37:20.350177Z","caller":"traceutil/trace.go:171","msg":"trace[737619014] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"119.670286ms","start":"2026-10-14T15:37:20.230485Z","end":"2026-10-14T15:37:20.350155Z","steps":["trace[737619014] 'process raft request' (duration: 119.450139ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:37:20.35024Z","caller":"traceutil/trace.go:171","msg":"trace[1029383434] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"101.735059ms","start":"2026-10-14T15:37:20.248469Z","end":"2026-10-14T15:37:20.350204Z","steps":["trace[1029383434] 'process raft request' (duration: 101.611945ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:37:20.350277Z","caller":"traceutil/trace.go:171","msg":"trace[1867263363] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"118.082081ms","start":"2026-10-14T15:37:20.232181Z","end":"2026-10-14T15:37:20.350263Z","steps":["trace[1867263363] 'process raft request' (duration: 117.861034ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:37:20.350361Z","caller":"traceutil/trace.go:171","msg":"trace[1052245115] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"101.790891ms","start":"2026-10-14T15:37:20.248548Z","end":"2026-10-14T15:37:20.350339Z","steps":["trace[1052245115] 'process raft request' (duration: 101.573435ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:37:54.712732Z","caller":"traceutil/trace.go:171","msg":"trace[1675409350] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"116.955386ms","start":"2026-10-14T15:37:54.59575Z","end":"2026-10-14T15:37:54.712706Z","steps":["trace[1675409350] 'process raft request' (duration: 116.783472ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:37:54.913081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.812665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:995"} {"level":"info","ts":"2026-10-14T15:37:54.91316Z","caller":"traceutil/trace.go:171","msg":"trace[1827203975] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:568; }","duration":"102.909977ms","start":"2026-10-14T15:37:54.810232Z","end":"2026-10-14T15:37:54.913142Z","steps":["trace[1827203975] 'agreement among raft nodes before linearized reading' (duration: 102.779334ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:37:54.913186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.931167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha1.gateway.networking.x-k8s.io\" ","response":"range_response_count:1 size:1019"} {"level":"info","ts":"2026-10-14T15:37:54.913245Z","caller":"traceutil/trace.go:171","msg":"trace[1778228379] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1alpha1.gateway.networking.x-k8s.io; range_end:; response_count:1; response_revision:568; }","duration":"103.017978ms","start":"2026-10-14T15:37:54.810213Z","end":"2026-10-14T15:37:54.913231Z","steps":["trace[1778228379] 'agreement among raft nodes before linearized reading' (duration: 102.881036ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:37:55.015512Z","caller":"traceutil/trace.go:171","msg":"trace[1043125268] linearizableReadLoop","detail":"{readStateIndex:593; appliedIndex:591; }","duration":"102.458825ms","start":"2026-10-14T15:37:54.912986Z","end":"2026-10-14T15:37:55.015445Z","steps":["trace[1043125268] 'read index received' (duration: 91.194514ms)","trace[1043125268] 'applied index is now lower than readState.Index' (duration: 11.263161ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T15:37:55.01568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.771631ms","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-10-14T15:37:55.015738Z","caller":"traceutil/trace.go:171","msg":"trace[182889204] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:570; }","duration":"133.876173ms","start":"2026-10-14T15:37:54.881844Z","end":"2026-10-14T15:37:55.01572Z","steps":["trace[182889204] 'agreement among raft nodes before linearized reading' (duration: 133.748321ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:37:55.015755Z","caller":"traceutil/trace.go:171","msg":"trace[1605413825] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"172.778567ms","start":"2026-10-14T15:37:54.842934Z","end":"2026-10-14T15:37:55.015713Z","steps":["trace[1605413825] 'process raft request' (duration: 161.234521ms)","trace[1605413825] 'compare' (duration: 10.975884ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:37:55.015802Z","caller":"traceutil/trace.go:171","msg":"trace[651755379] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"141.658684ms","start":"2026-10-14T15:37:54.874117Z","end":"2026-10-14T15:37:55.015775Z","steps":["trace[651755379] 'process raft request' (duration: 141.186125ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:37:55.696874Z","caller":"traceutil/trace.go:171","msg":"trace[587692196] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"297.189581ms","start":"2026-10-14T15:37:55.399661Z","end":"2026-10-14T15:37:55.69685Z","steps":["trace[587692196] 'process raft request' (duration: 296.951706ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:37:55.710289Z","caller":"traceutil/trace.go:171","msg":"trace[2136243918] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"302.451729ms","start":"2026-10-14T15:37:55.4078Z","end":"2026-10-14T15:37:55.710252Z","steps":["trace[2136243918] 'process raft request' (duration: 302.122433ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:37:55.710331Z","caller":"traceutil/trace.go:171","msg":"trace[354586442] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"270.76007ms","start":"2026-10-14T15:37:55.439551Z","end":"2026-10-14T15:37:55.710311Z","steps":["trace[354586442] 'process raft request' (duration: 270.587336ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:37:55.710938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:37:55.407783Z","time spent":"302.610432ms","remote":"127.0.0.1:34600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":73770,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T15:38:00.682394Z","caller":"traceutil/trace.go:171","msg":"trace[280642180] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"176.449996ms","start":"2026-10-14T15:38:00.505913Z","end":"2026-10-14T15:38:00.682363Z","steps":["trace[280642180] 'process raft request' (duration: 175.807014ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:38:02.289416Z","caller":"traceutil/trace.go:171","msg":"trace[1541831473] linearizableReadLoop","detail":"{readStateIndex:671; appliedIndex:670; }","duration":"484.01198ms","start":"2026-10-14T15:38:01.805375Z","end":"2026-10-14T15:38:02.289387Z","steps":["trace[1541831473] 'read index received' (duration: 482.925129ms)","trace[1541831473] 'applied index is now lower than readState.Index' (duration: 1.085541ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:38:02.289515Z","caller":"traceutil/trace.go:171","msg":"trace[1911119049] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"532.736913ms","start":"2026-10-14T15:38:01.756753Z","end":"2026-10-14T15:38:02.28949Z","steps":["trace[1911119049] 'process raft request' (duration: 531.953218ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:38:02.289633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.677694ms","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-10-14T15:38:02.289827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.444459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-6cv28\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-10-14T15:38:02.289884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:38:01.756723Z","time spent":"532.847255ms","remote":"127.0.0.1:34662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T15:38:02.289906Z","caller":"traceutil/trace.go:171","msg":"trace[273777663] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:647; }","duration":"305.775565ms","start":"2026-10-14T15:38:01.983897Z","end":"2026-10-14T15:38:02.289672Z","steps":["trace[273777663] 'agreement among raft nodes before linearized reading' (duration: 305.675294ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:38:02.289967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:38:01.983876Z","time spent":"306.074582ms","remote":"127.0.0.1:34836","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-10-14T15:38:02.289978Z","caller":"traceutil/trace.go:171","msg":"trace[494059713] range","detail":"{range_begin:/registry/pods/kube-system/cilium-6cv28; range_end:; response_count:1; response_revision:647; }","duration":"484.592281ms","start":"2026-10-14T15:38:01.805327Z","end":"2026-10-14T15:38:02.289919Z","steps":["trace[494059713] 'agreement among raft nodes before linearized reading' (duration: 484.312536ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:38:02.290086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:38:01.805307Z","time spent":"484.764135ms","remote":"127.0.0.1:34746","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-6cv28\" "} {"level":"warn","ts":"2026-10-14T15:38:02.290069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.7114ms","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-10-14T15:38:02.290302Z","caller":"traceutil/trace.go:171","msg":"trace[1925613006] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:647; }","duration":"256.992706ms","start":"2026-10-14T15:38:02.033284Z","end":"2026-10-14T15:38:02.290276Z","steps":["trace[1925613006] 'agreement among raft nodes before linearized reading' (duration: 256.549878ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:38:18.121412Z","caller":"traceutil/trace.go:171","msg":"trace[324350503] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"210.674688ms","start":"2026-10-14T15:38:17.910669Z","end":"2026-10-14T15:38:18.121344Z","steps":["trace[324350503] 'process raft request' (duration: 210.482675ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:38:48.701934Z","caller":"traceutil/trace.go:171","msg":"trace[1137484456] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"167.940317ms","start":"2026-10-14T15:38:48.533962Z","end":"2026-10-14T15:38:48.701903Z","steps":["trace[1137484456] 'process raft request' (duration: 167.774624ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:38:48.704314Z","caller":"traceutil/trace.go:171","msg":"trace[1698853648] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"170.104847ms","start":"2026-10-14T15:38:48.534187Z","end":"2026-10-14T15:38:48.704291Z","steps":["trace[1698853648] 'process raft request' (duration: 169.999326ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:39:16.575609Z","caller":"traceutil/trace.go:171","msg":"trace[947645444] transaction","detail":"{read_only:false; response_revision:1518; number_of_response:1; }","duration":"142.628756ms","start":"2026-10-14T15:39:16.432953Z","end":"2026-10-14T15:39:16.575582Z","steps":["trace[947645444] 'process raft request' (duration: 140.536319ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:39:16.755055Z","caller":"traceutil/trace.go:171","msg":"trace[1703895672] linearizableReadLoop","detail":"{readStateIndex:1566; appliedIndex:1564; }","duration":"276.817063ms","start":"2026-10-14T15:39:16.478214Z","end":"2026-10-14T15:39:16.755031Z","steps":["trace[1703895672] 'read index received' (duration: 95.369894ms)","trace[1703895672] 'applied index is now lower than readState.Index' (duration: 181.445839ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T15:39:16.755428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.128897ms","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-10-14T15:39:16.755518Z","caller":"traceutil/trace.go:171","msg":"trace[97445676] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1519; }","duration":"277.457231ms","start":"2026-10-14T15:39:16.478039Z","end":"2026-10-14T15:39:16.755496Z","steps":["trace[97445676] 'agreement among raft nodes before linearized reading' (duration: 277.220328ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:39:16.755203Z","caller":"traceutil/trace.go:171","msg":"trace[1389636127] transaction","detail":"{read_only:false; response_revision:1519; number_of_response:1; }","duration":"303.906284ms","start":"2026-10-14T15:39:16.451269Z","end":"2026-10-14T15:39:16.755176Z","steps":["trace[1389636127] 'process raft request' (duration: 268.493625ms)","trace[1389636127] 'compare' (duration: 35.130635ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:39:16.756103Z","caller":"traceutil/trace.go:171","msg":"trace[1319350321] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1520; }","duration":"179.185799ms","start":"2026-10-14T15:39:16.576892Z","end":"2026-10-14T15:39:16.756078Z","steps":["trace[1319350321] 'process raft request' (duration: 178.45525ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:39:16.756126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:39:16.451241Z","time spent":"304.777315ms","remote":"127.0.0.1:34662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105428,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T15:39:38.550143Z","caller":"traceutil/trace.go:171","msg":"trace[1320785776] linearizableReadLoop","detail":"{readStateIndex:1913; appliedIndex:1910; }","duration":"221.945402ms","start":"2026-10-14T15:39:38.328174Z","end":"2026-10-14T15:39:38.550119Z","steps":["trace[1320785776] 'read index received' (duration: 134.633197ms)","trace[1320785776] 'applied index is now lower than readState.Index' (duration: 87.311295ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:39:38.550165Z","caller":"traceutil/trace.go:171","msg":"trace[1909348027] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"254.801729ms","start":"2026-10-14T15:39:38.295337Z","end":"2026-10-14T15:39:38.550138Z","steps":["trace[1909348027] 'process raft request' (duration: 254.699938ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:39:38.550216Z","caller":"traceutil/trace.go:171","msg":"trace[1895098501] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"259.00281ms","start":"2026-10-14T15:39:38.291186Z","end":"2026-10-14T15:39:38.550189Z","steps":["trace[1895098501] 'process raft request' (duration: 171.554923ms)","trace[1895098501] 'compare' (duration: 87.157143ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:39:38.550314Z","caller":"traceutil/trace.go:171","msg":"trace[1987023759] transaction","detail":"{read_only:false; response_revision:1839; number_of_response:1; }","duration":"243.031397ms","start":"2026-10-14T15:39:38.307257Z","end":"2026-10-14T15:39:38.550288Z","steps":["trace[1987023759] 'process raft request' (duration: 242.825505ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:39:38.550346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.099594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T15:39:38.55044Z","caller":"traceutil/trace.go:171","msg":"trace[2136957167] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1839; }","duration":"222.237325ms","start":"2026-10-14T15:39:38.328136Z","end":"2026-10-14T15:39:38.550373Z","steps":["trace[2136957167] 'agreement among raft nodes before linearized reading' (duration: 222.079863ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:39:38.551342Z","caller":"traceutil/trace.go:171","msg":"trace[1716702430] transaction","detail":"{read_only:false; response_revision:1842; number_of_response:1; }","duration":"217.173505ms","start":"2026-10-14T15:39:38.334149Z","end":"2026-10-14T15:39:38.551322Z","steps":["trace[1716702430] 'process raft request' (duration: 217.098844ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:39:38.551443Z","caller":"traceutil/trace.go:171","msg":"trace[1134633438] transaction","detail":"{read_only:false; response_revision:1840; number_of_response:1; }","duration":"221.938782ms","start":"2026-10-14T15:39:38.329487Z","end":"2026-10-14T15:39:38.551426Z","steps":["trace[1134633438] 'process raft request' (duration: 221.556377ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:39:38.551891Z","caller":"traceutil/trace.go:171","msg":"trace[1140856713] transaction","detail":"{read_only:false; response_revision:1841; number_of_response:1; }","duration":"221.721849ms","start":"2026-10-14T15:39:38.330122Z","end":"2026-10-14T15:39:38.551844Z","steps":["trace[1140856713] 'process raft request' (duration: 221.047911ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:39:38.763815Z","caller":"traceutil/trace.go:171","msg":"trace[2038977377] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"110.547176ms","start":"2026-10-14T15:39:38.653246Z","end":"2026-10-14T15:39:38.763793Z","steps":["trace[2038977377] 'process raft request' (duration: 110.319944ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:39:38.764288Z","caller":"traceutil/trace.go:171","msg":"trace[1615475139] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"103.678003ms","start":"2026-10-14T15:39:38.660569Z","end":"2026-10-14T15:39:38.764247Z","steps":["trace[1615475139] 'process raft request' (duration: 103.122436ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:39:38.764285Z","caller":"traceutil/trace.go:171","msg":"trace[1221960866] linearizableReadLoop","detail":"{readStateIndex:1929; appliedIndex:1927; }","duration":"109.784536ms","start":"2026-10-14T15:39:38.65442Z","end":"2026-10-14T15:39:38.764205Z","steps":["trace[1221960866] 'read index received' (duration: 51.050166ms)","trace[1221960866] 'applied index is now lower than readState.Index' (duration: 58.73045ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T15:39:38.764805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.338333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:6635"} {"level":"info","ts":"2026-10-14T15:39:38.764875Z","caller":"traceutil/trace.go:171","msg":"trace[1243282665] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1856; }","duration":"110.460845ms","start":"2026-10-14T15:39:38.654397Z","end":"2026-10-14T15:39:38.764858Z","steps":["trace[1243282665] 'agreement among raft nodes before linearized reading' (duration: 109.973379ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:39:42.183469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.199472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T15:39:42.183606Z","caller":"traceutil/trace.go:171","msg":"trace[9820939] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1914; }","duration":"450.374685ms","start":"2026-10-14T15:39:41.733167Z","end":"2026-10-14T15:39:42.183542Z","steps":["trace[9820939] 'count revisions from in-memory index tree' (duration: 449.98752ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:39:42.183668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T15:39:41.733141Z","time spent":"450.507836ms","remote":"127.0.0.1:38144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-10-14T15:39:42.184076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.025452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c944ab60-2aed-4f8f-995a-15318607a212\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-10-14T15:39:42.184154Z","caller":"traceutil/trace.go:171","msg":"trace[2043106529] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c944ab60-2aed-4f8f-995a-15318607a212; range_end:; response_count:1; response_revision:1914; }","duration":"290.104083ms","start":"2026-10-14T15:39:41.894033Z","end":"2026-10-14T15:39:42.184137Z","steps":["trace[2043106529] 'range keys from in-memory index tree' (duration: 289.791549ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:39:42.544682Z","caller":"traceutil/trace.go:171","msg":"trace[151875016] transaction","detail":"{read_only:false; response_revision:1915; number_of_response:1; }","duration":"192.548762ms","start":"2026-10-14T15:39:42.35211Z","end":"2026-10-14T15:39:42.544659Z","steps":["trace[151875016] 'process raft request' (duration: 192.36681ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:39:42.544892Z","caller":"traceutil/trace.go:171","msg":"trace[1133122707] linearizableReadLoop","detail":"{readStateIndex:1990; appliedIndex:1990; }","duration":"180.404047ms","start":"2026-10-14T15:39:42.364475Z","end":"2026-10-14T15:39:42.544879Z","steps":["trace[1133122707] 'read index received' (duration: 180.399097ms)","trace[1133122707] 'applied index is now lower than readState.Index' (duration: 3.78µs)"],"step_count":2} {"level":"warn","ts":"2026-10-14T15:39:42.545144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.64238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-10-14T15:39:42.545205Z","caller":"traceutil/trace.go:171","msg":"trace[1281374477] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1915; }","duration":"180.738862ms","start":"2026-10-14T15:39:42.364431Z","end":"2026-10-14T15:39:42.54517Z","steps":["trace[1281374477] 'agreement among raft nodes before linearized reading' (duration: 180.517469ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:39:42.875384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.998623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-10-14T15:39:42.876004Z","caller":"traceutil/trace.go:171","msg":"trace[225461520] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1915; }","duration":"277.208765ms","start":"2026-10-14T15:39:42.59832Z","end":"2026-10-14T15:39:42.875528Z","steps":["trace[225461520] 'range keys from in-memory index tree' (duration: 276.857281ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:39:54.920375Z","caller":"traceutil/trace.go:171","msg":"trace[367520024] transaction","detail":"{read_only:false; response_revision:2014; number_of_response:1; }","duration":"117.88074ms","start":"2026-10-14T15:39:54.802469Z","end":"2026-10-14T15:39:54.920349Z","steps":["trace[367520024] 'process raft request' (duration: 117.725248ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:40:17.101738Z","caller":"traceutil/trace.go:171","msg":"trace[1621187282] transaction","detail":"{read_only:false; response_revision:2150; number_of_response:1; }","duration":"126.691821ms","start":"2026-10-14T15:40:16.975022Z","end":"2026-10-14T15:40:17.101714Z","steps":["trace[1621187282] 'process raft request' (duration: 126.55566ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:40:17.197116Z","caller":"traceutil/trace.go:171","msg":"trace[466987267] linearizableReadLoop","detail":"{readStateIndex:2233; appliedIndex:2231; }","duration":"128.151117ms","start":"2026-10-14T15:40:17.068939Z","end":"2026-10-14T15:40:17.19709Z","steps":["trace[466987267] 'read index received' (duration: 32.515582ms)","trace[466987267] 'applied index is now lower than readState.Index' (duration: 95.634155ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:40:17.197167Z","caller":"traceutil/trace.go:171","msg":"trace[1828112365] transaction","detail":"{read_only:false; response_revision:2151; number_of_response:1; }","duration":"181.899206ms","start":"2026-10-14T15:40:17.015209Z","end":"2026-10-14T15:40:17.197108Z","steps":["trace[1828112365] 'process raft request' (duration: 181.292509ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:40:17.197322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.37059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-10-14T15:40:17.197374Z","caller":"traceutil/trace.go:171","msg":"trace[600067835] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2151; }","duration":"128.45324ms","start":"2026-10-14T15:40:17.068905Z","end":"2026-10-14T15:40:17.197358Z","steps":["trace[600067835] 'agreement among raft nodes before linearized reading' (duration: 128.309299ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:40:17.197398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.401091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-10-14T15:40:17.197436Z","caller":"traceutil/trace.go:171","msg":"trace[763145492] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2151; }","duration":"128.483871ms","start":"2026-10-14T15:40:17.068939Z","end":"2026-10-14T15:40:17.197422Z","steps":["trace[763145492] 'agreement among raft nodes before linearized reading' (duration: 128.34376ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:40:17.481335Z","caller":"traceutil/trace.go:171","msg":"trace[1320907116] linearizableReadLoop","detail":"{readStateIndex:2235; appliedIndex:2233; }","duration":"200.399611ms","start":"2026-10-14T15:40:17.280914Z","end":"2026-10-14T15:40:17.481314Z","steps":["trace[1320907116] 'read index received' (duration: 101.321238ms)","trace[1320907116] 'applied index is now lower than readState.Index' (duration: 99.077393ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:40:17.48146Z","caller":"traceutil/trace.go:171","msg":"trace[846433436] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"275.972854ms","start":"2026-10-14T15:40:17.205473Z","end":"2026-10-14T15:40:17.481446Z","steps":["trace[846433436] 'process raft request' (duration: 176.689718ms)","trace[846433436] 'compare' (duration: 98.953442ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T15:40:17.481696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.877386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-10-14T15:40:17.481759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.827086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-14T15:40:17.481861Z","caller":"traceutil/trace.go:171","msg":"trace[533834532] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:2153; }","duration":"200.963378ms","start":"2026-10-14T15:40:17.28088Z","end":"2026-10-14T15:40:17.481844Z","steps":["trace[533834532] 'agreement among raft nodes before linearized reading' (duration: 200.580234ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:40:17.481875Z","caller":"traceutil/trace.go:171","msg":"trace[2133594075] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"276.035544ms","start":"2026-10-14T15:40:17.205818Z","end":"2026-10-14T15:40:17.481854Z","steps":["trace[2133594075] 'process raft request' (duration: 275.430528ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:40:17.481788Z","caller":"traceutil/trace.go:171","msg":"trace[653300704] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2153; }","duration":"112.013827ms","start":"2026-10-14T15:40:17.369759Z","end":"2026-10-14T15:40:17.481773Z","steps":["trace[653300704] 'agreement among raft nodes before linearized reading' (duration: 111.815475ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:44:47.126988Z","caller":"traceutil/trace.go:171","msg":"trace[2049819910] transaction","detail":"{read_only:false; response_revision:3774; number_of_response:1; }","duration":"122.36144ms","start":"2026-10-14T15:44:47.004606Z","end":"2026-10-14T15:44:47.126967Z","steps":["trace[2049819910] 'process raft request' (duration: 122.305099ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:44:47.127142Z","caller":"traceutil/trace.go:171","msg":"trace[227719219] transaction","detail":"{read_only:false; response_revision:3773; number_of_response:1; }","duration":"125.089046ms","start":"2026-10-14T15:44:47.001924Z","end":"2026-10-14T15:44:47.127013Z","steps":["trace[227719219] 'process raft request' (duration: 91.105056ms)","trace[227719219] 'compare' (duration: 33.779336ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:46:07.502258Z","caller":"traceutil/trace.go:171","msg":"trace[951585871] transaction","detail":"{read_only:false; response_revision:4286; number_of_response:1; }","duration":"114.294677ms","start":"2026-10-14T15:46:07.387944Z","end":"2026-10-14T15:46:07.502238Z","steps":["trace[951585871] 'process raft request' (duration: 65.411674ms)","trace[951585871] 'compare' (duration: 48.772401ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:46:07.502963Z","caller":"traceutil/trace.go:171","msg":"trace[527421362] transaction","detail":"{read_only:false; response_revision:4287; number_of_response:1; }","duration":"114.190556ms","start":"2026-10-14T15:46:07.388761Z","end":"2026-10-14T15:46:07.502951Z","steps":["trace[527421362] 'process raft request' (duration: 114.043794ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:46:07.503242Z","caller":"traceutil/trace.go:171","msg":"trace[1900383324] transaction","detail":"{read_only:false; response_revision:4288; number_of_response:1; }","duration":"114.404099ms","start":"2026-10-14T15:46:07.388827Z","end":"2026-10-14T15:46:07.503231Z","steps":["trace[1900383324] 'process raft request' (duration: 114.065054ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:46:18.3564Z","caller":"traceutil/trace.go:171","msg":"trace[33734233] transaction","detail":"{read_only:false; response_revision:4773; number_of_response:1; }","duration":"106.413932ms","start":"2026-10-14T15:46:18.248823Z","end":"2026-10-14T15:46:18.355237Z","steps":["trace[33734233] 'process raft request' (duration: 106.30133ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:46:24.101209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.307045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"warn","ts":"2026-10-14T15:46:24.101214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.169669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-10-14T15:46:24.10131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.58682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-14T15:46:24.101327Z","caller":"traceutil/trace.go:171","msg":"trace[270828266] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4897; }","duration":"299.463717ms","start":"2026-10-14T15:46:23.80184Z","end":"2026-10-14T15:46:24.101303Z","steps":["trace[270828266] 'range keys from in-memory index tree' (duration: 299.113913ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:46:24.101341Z","caller":"traceutil/trace.go:171","msg":"trace[400919843] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4897; }","duration":"246.325711ms","start":"2026-10-14T15:46:23.854994Z","end":"2026-10-14T15:46:24.10132Z","steps":["trace[400919843] 'range keys from in-memory index tree' (duration: 246.034097ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:46:24.101357Z","caller":"traceutil/trace.go:171","msg":"trace[1170523217] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4897; }","duration":"283.658111ms","start":"2026-10-14T15:46:23.817685Z","end":"2026-10-14T15:46:24.101344Z","steps":["trace[1170523217] 'range keys from in-memory index tree' (duration: 283.435657ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:46:25.418997Z","caller":"traceutil/trace.go:171","msg":"trace[142960417] transaction","detail":"{read_only:false; response_revision:4907; number_of_response:1; }","duration":"118.725157ms","start":"2026-10-14T15:46:25.300243Z","end":"2026-10-14T15:46:25.418968Z","steps":["trace[142960417] 'process raft request' (duration: 118.474493ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:46:30.301117Z","caller":"traceutil/trace.go:171","msg":"trace[2002323908] transaction","detail":"{read_only:false; response_revision:4996; number_of_response:1; }","duration":"101.497713ms","start":"2026-10-14T15:46:30.199601Z","end":"2026-10-14T15:46:30.301098Z","steps":["trace[2002323908] 'process raft request' (duration: 101.086197ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:46:30.435509Z","caller":"traceutil/trace.go:171","msg":"trace[680794408] linearizableReadLoop","detail":"{readStateIndex:5188; appliedIndex:5187; }","duration":"108.355075ms","start":"2026-10-14T15:46:30.327126Z","end":"2026-10-14T15:46:30.435481Z","steps":["trace[680794408] 'read index received' (duration: 73.674038ms)","trace[680794408] 'applied index is now lower than readState.Index' (duration: 34.679807ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T15:46:30.435735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.576958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T15:46:30.435688Z","caller":"traceutil/trace.go:171","msg":"trace[2014339159] transaction","detail":"{read_only:false; response_revision:4997; number_of_response:1; }","duration":"131.660683ms","start":"2026-10-14T15:46:30.303953Z","end":"2026-10-14T15:46:30.435613Z","steps":["trace[2014339159] 'process raft request' (duration: 96.926335ms)","trace[2014339159] 'compare' (duration: 34.370362ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:46:30.435773Z","caller":"traceutil/trace.go:171","msg":"trace[181950715] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4997; }","duration":"108.68687ms","start":"2026-10-14T15:46:30.327076Z","end":"2026-10-14T15:46:30.435763Z","steps":["trace[181950715] 'agreement among raft nodes before linearized reading' (duration: 108.582809ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:46:34.994901Z","caller":"traceutil/trace.go:171","msg":"trace[1103251485] transaction","detail":"{read_only:false; response_revision:5061; number_of_response:1; }","duration":"101.838654ms","start":"2026-10-14T15:46:34.893032Z","end":"2026-10-14T15:46:34.994871Z","steps":["trace[1103251485] 'process raft request' (duration: 101.672721ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:46:34.999869Z","caller":"traceutil/trace.go:171","msg":"trace[892283927] transaction","detail":"{read_only:false; response_revision:5062; number_of_response:1; }","duration":"102.546113ms","start":"2026-10-14T15:46:34.897303Z","end":"2026-10-14T15:46:34.999849Z","steps":["trace[892283927] 'process raft request' (duration: 102.388871ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:46:44.693206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.349189ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T15:46:44.693483Z","caller":"traceutil/trace.go:171","msg":"trace[344786874] transaction","detail":"{read_only:false; response_revision:5188; number_of_response:1; }","duration":"149.891751ms","start":"2026-10-14T15:46:44.543559Z","end":"2026-10-14T15:46:44.693451Z","steps":["trace[344786874] 'compare' (duration: 146.219177ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:46:44.693545Z","caller":"traceutil/trace.go:171","msg":"trace[716237561] transaction","detail":"{read_only:false; response_revision:5190; number_of_response:1; }","duration":"147.590837ms","start":"2026-10-14T15:46:44.545946Z","end":"2026-10-14T15:46:44.693537Z","steps":["trace[716237561] 'process raft request' (duration: 147.457315ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:46:44.693512Z","caller":"traceutil/trace.go:171","msg":"trace[1386711117] transaction","detail":"{read_only:false; response_revision:5189; number_of_response:1; }","duration":"147.932843ms","start":"2026-10-14T15:46:44.545566Z","end":"2026-10-14T15:46:44.693499Z","steps":["trace[1386711117] 'process raft request' (duration: 147.7779ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:46:44.693701Z","caller":"traceutil/trace.go:171","msg":"trace[1030525360] linearizableReadLoop","detail":"{readStateIndex:5388; appliedIndex:5384; }","duration":"109.682048ms","start":"2026-10-14T15:46:44.583996Z","end":"2026-10-14T15:46:44.693678Z","steps":["trace[1030525360] 'read index received' (duration: 79.654975ms)","trace[1030525360] 'applied index is now lower than readState.Index' (duration: 30.025863ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:46:44.693874Z","caller":"traceutil/trace.go:171","msg":"trace[565958510] transaction","detail":"{read_only:false; response_revision:5191; number_of_response:1; }","duration":"146.621943ms","start":"2026-10-14T15:46:44.547243Z","end":"2026-10-14T15:46:44.693865Z","steps":["trace[565958510] 'process raft request' (duration: 146.221347ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:46:44.693922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.918822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-10-14T15:46:44.693979Z","caller":"traceutil/trace.go:171","msg":"trace[138507766] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5191; }","duration":"110.012733ms","start":"2026-10-14T15:46:44.58395Z","end":"2026-10-14T15:46:44.693962Z","steps":["trace[138507766] 'agreement among raft nodes before linearized reading' (duration: 109.80957ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T15:46:45.126461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.695456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-755d77ffbb-jtrv8\" ","response":"range_response_count:1 size:11845"} {"level":"info","ts":"2026-10-14T15:46:45.126559Z","caller":"traceutil/trace.go:171","msg":"trace[1305551643] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-grafana-755d77ffbb-jtrv8; range_end:; response_count:1; response_revision:5191; }","duration":"233.864918ms","start":"2026-10-14T15:46:44.892665Z","end":"2026-10-14T15:46:45.12653Z","steps":["trace[1305551643] 'range keys from in-memory index tree' (duration: 233.451873ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:47:10.653267Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2874} {"level":"info","ts":"2026-10-14T15:47:10.725418Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2874,"took":"70.883568ms","hash":1937716333,"current-db-size-bytes":51007488,"current-db-size":"51 MB","current-db-size-in-use-bytes":27594752,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-14T15:47:10.72547Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1937716333,"revision":2874,"compact-revision":-1} {"level":"info","ts":"2026-10-14T15:47:28.422542Z","caller":"traceutil/trace.go:171","msg":"trace[1365795606] linearizableReadLoop","detail":"{readStateIndex:5758; appliedIndex:5757; }","duration":"170.074043ms","start":"2026-10-14T15:47:28.25243Z","end":"2026-10-14T15:47:28.422504Z","steps":["trace[1365795606] 'read index received' (duration: 73.905302ms)","trace[1365795606] 'applied index is now lower than readState.Index' (duration: 96.167481ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:47:28.422728Z","caller":"traceutil/trace.go:171","msg":"trace[1318287473] transaction","detail":"{read_only:false; response_revision:5551; number_of_response:1; }","duration":"294.727783ms","start":"2026-10-14T15:47:28.127983Z","end":"2026-10-14T15:47:28.42271Z","steps":["trace[1318287473] 'process raft request' (duration: 198.42904ms)","trace[1318287473] 'compare' (duration: 95.745525ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T15:47:28.423462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.992306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-14T15:47:28.423528Z","caller":"traceutil/trace.go:171","msg":"trace[1534023034] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:5551; }","duration":"171.121117ms","start":"2026-10-14T15:47:28.252389Z","end":"2026-10-14T15:47:28.42351Z","steps":["trace[1534023034] 'agreement among raft nodes before linearized reading' (duration: 170.989125ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:49:31.704596Z","caller":"traceutil/trace.go:171","msg":"trace[1655949148] transaction","detail":"{read_only:false; response_revision:6325; number_of_response:1; }","duration":"159.76063ms","start":"2026-10-14T15:49:31.544807Z","end":"2026-10-14T15:49:31.704568Z","steps":["trace[1655949148] 'process raft request' (duration: 159.140219ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T15:50:50.497057Z","caller":"traceutil/trace.go:171","msg":"trace[1911440207] transaction","detail":"{read_only:false; response_revision:6969; number_of_response:1; }","duration":"146.562145ms","start":"2026-10-14T15:50:50.350471Z","end":"2026-10-14T15:50:50.497034Z","steps":["trace[1911440207] 'process raft request' (duration: 64.263094ms)","trace[1911440207] 'compare' (duration: 82.210208ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T15:52:10.664131Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5360} {"level":"info","ts":"2026-10-14T15:52:10.754553Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5360,"took":"88.299513ms","hash":3718777026,"current-db-size-bytes":51007488,"current-db-size":"51 MB","current-db-size-in-use-bytes":18726912,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-10-14T15:52:10.754644Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3718777026,"revision":5360,"compact-revision":2874}