{"level":"warn","ts":"2026-10-14T13:34:41.911856Z","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-14T13:34:41.911943Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.31:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.31:2380","--initial-cluster=instance=https://199.19.213.31:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.31:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.31: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-14T13:34:41.912025Z","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-14T13:34:41.91204Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.31:2380"]} {"level":"info","ts":"2026-10-14T13:34:41.912064Z","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-14T13:34:41.912739Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.31:2379"]} {"level":"info","ts":"2026-10-14T13:34:41.912827Z","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":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.31:2380"],"listen-peer-urls":["https://199.19.213.31:2380"],"advertise-client-urls":["https://199.19.213.31:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.31:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.31: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-14T13:34:41.917763Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.702841ms"} {"level":"info","ts":"2026-10-14T13:34:41.929389Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b3aa5b67741e7c5e","cluster-id":"9896be1db1fb000"} {"level":"info","ts":"2026-10-14T13:34:41.929496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3aa5b67741e7c5e switched to configuration voters=()"} {"level":"info","ts":"2026-10-14T13:34:41.929518Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3aa5b67741e7c5e became follower at term 0"} {"level":"info","ts":"2026-10-14T13:34:41.929528Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b3aa5b67741e7c5e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-14T13:34:41.929539Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3aa5b67741e7c5e became follower at term 1"} {"level":"info","ts":"2026-10-14T13:34:41.929726Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3aa5b67741e7c5e switched to configuration voters=(12946260578717826142)"} {"level":"warn","ts":"2026-10-14T13:34:41.945899Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-14T13:34:41.94795Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-14T13:34:41.950444Z","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-14T13:34:41.95345Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b3aa5b67741e7c5e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-14T13:34:41.953904Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b3aa5b67741e7c5e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-14T13:34:41.954013Z","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-14T13:34:41.954175Z","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-14T13:34:41.954197Z","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-14T13:34:41.954889Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3aa5b67741e7c5e switched to configuration voters=(12946260578717826142)"} {"level":"info","ts":"2026-10-14T13:34:41.955031Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9896be1db1fb000","local-member-id":"b3aa5b67741e7c5e","added-peer-id":"b3aa5b67741e7c5e","added-peer-peer-urls":["https://199.19.213.31:2380"]} {"level":"info","ts":"2026-10-14T13:34:41.957924Z","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-14T13:34:41.958068Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.31:2380"} {"level":"info","ts":"2026-10-14T13:34:41.958198Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.31:2380"} {"level":"info","ts":"2026-10-14T13:34:41.958269Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b3aa5b67741e7c5e","initial-advertise-peer-urls":["https://199.19.213.31:2380"],"listen-peer-urls":["https://199.19.213.31:2380"],"advertise-client-urls":["https://199.19.213.31:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.31:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-14T13:34:41.958333Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-14T13:34:42.530689Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3aa5b67741e7c5e is starting a new election at term 1"} {"level":"info","ts":"2026-10-14T13:34:42.530745Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3aa5b67741e7c5e became pre-candidate at term 1"} {"level":"info","ts":"2026-10-14T13:34:42.530768Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3aa5b67741e7c5e received MsgPreVoteResp from b3aa5b67741e7c5e at term 1"} {"level":"info","ts":"2026-10-14T13:34:42.530835Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3aa5b67741e7c5e became candidate at term 2"} {"level":"info","ts":"2026-10-14T13:34:42.530852Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3aa5b67741e7c5e received MsgVoteResp from b3aa5b67741e7c5e at term 2"} {"level":"info","ts":"2026-10-14T13:34:42.530871Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b3aa5b67741e7c5e became leader at term 2"} {"level":"info","ts":"2026-10-14T13:34:42.530919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b3aa5b67741e7c5e elected leader b3aa5b67741e7c5e at term 2"} {"level":"info","ts":"2026-10-14T13:34:42.53216Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T13:34:42.53278Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b3aa5b67741e7c5e","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.31:2379]}","request-path":"/0/members/b3aa5b67741e7c5e/attributes","cluster-id":"9896be1db1fb000","publish-timeout":"7s"} {"level":"info","ts":"2026-10-14T13:34:42.53279Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-14T13:34:42.532851Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-14T13:34:42.533123Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-14T13:34:42.53316Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-14T13:34:42.533478Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9896be1db1fb000","local-member-id":"b3aa5b67741e7c5e","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T13:34:42.533648Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T13:34:42.533718Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T13:34:42.539361Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.31:2379"} {"level":"info","ts":"2026-10-14T13:34:42.540183Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-14T13:34:56.785576Z","caller":"traceutil/trace.go:171","msg":"trace[1548130033] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"122.863493ms","start":"2026-10-14T13:34:56.662682Z","end":"2026-10-14T13:34:56.785546Z","steps":["trace[1548130033] 'process raft request' (duration: 122.691608ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:35:25.537219Z","caller":"traceutil/trace.go:171","msg":"trace[1858145211] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"121.65088ms","start":"2026-10-14T13:35:25.415546Z","end":"2026-10-14T13:35:25.537196Z","steps":["trace[1858145211] 'process raft request' (duration: 121.477155ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:35:25.542605Z","caller":"traceutil/trace.go:171","msg":"trace[1903380905] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"108.621457ms","start":"2026-10-14T13:35:25.433879Z","end":"2026-10-14T13:35:25.542501Z","steps":["trace[1903380905] 'process raft request' (duration: 108.315878ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:35:25.542868Z","caller":"traceutil/trace.go:171","msg":"trace[148852626] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"108.806622ms","start":"2026-10-14T13:35:25.434022Z","end":"2026-10-14T13:35:25.542828Z","steps":["trace[148852626] 'process raft request' (duration: 108.346779ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:35:25.543043Z","caller":"traceutil/trace.go:171","msg":"trace[1326184978] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"107.100154ms","start":"2026-10-14T13:35:25.435892Z","end":"2026-10-14T13:35:25.542992Z","steps":["trace[1326184978] 'process raft request' (duration: 106.787096ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:35:25.700056Z","caller":"traceutil/trace.go:171","msg":"trace[1140365455] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"108.37846ms","start":"2026-10-14T13:35:25.591648Z","end":"2026-10-14T13:35:25.700026Z","steps":["trace[1140365455] 'process raft request' (duration: 103.545505ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:35:32.354428Z","caller":"traceutil/trace.go:171","msg":"trace[1782380594] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"164.285029ms","start":"2026-10-14T13:35:32.190098Z","end":"2026-10-14T13:35:32.354383Z","steps":["trace[1782380594] 'process raft request' (duration: 162.767677ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:35:32.555914Z","caller":"traceutil/trace.go:171","msg":"trace[370144926] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"129.414184ms","start":"2026-10-14T13:35:32.426459Z","end":"2026-10-14T13:35:32.555874Z","steps":["trace[370144926] 'process raft request' (duration: 104.902665ms)","trace[370144926] 'compare' (duration: 24.342554ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:35:33.097729Z","caller":"traceutil/trace.go:171","msg":"trace[12140800] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:653; }","duration":"111.773285ms","start":"2026-10-14T13:35:32.985923Z","end":"2026-10-14T13:35:33.097697Z","steps":["trace[12140800] 'read index received' (duration: 111.732234ms)","trace[12140800] 'applied index is now lower than readState.Index' (duration: 39.821µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:35:33.097819Z","caller":"traceutil/trace.go:171","msg":"trace[1485251329] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"147.997198ms","start":"2026-10-14T13:35:32.949781Z","end":"2026-10-14T13:35:33.097779Z","steps":["trace[1485251329] 'process raft request' (duration: 147.71134ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:35:33.09796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.024332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-4ntjb\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-10-14T13:35:33.098058Z","caller":"traceutil/trace.go:171","msg":"trace[986366554] range","detail":"{range_begin:/registry/pods/kube-system/cilium-4ntjb; range_end:; response_count:1; response_revision:629; }","duration":"112.244408ms","start":"2026-10-14T13:35:32.985797Z","end":"2026-10-14T13:35:33.098042Z","steps":["trace[986366554] 'agreement among raft nodes before linearized reading' (duration: 112.019741ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:35:33.108863Z","caller":"traceutil/trace.go:171","msg":"trace[537430987] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"103.164066ms","start":"2026-10-14T13:35:33.005669Z","end":"2026-10-14T13:35:33.108833Z","steps":["trace[537430987] 'process raft request' (duration: 102.58211ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:36:18.102486Z","caller":"traceutil/trace.go:171","msg":"trace[1833362037] transaction","detail":"{read_only:false; response_revision:1186; number_of_response:1; }","duration":"132.725875ms","start":"2026-10-14T13:36:17.969736Z","end":"2026-10-14T13:36:18.102462Z","steps":["trace[1833362037] 'process raft request' (duration: 132.595911ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:37:06.871999Z","caller":"traceutil/trace.go:171","msg":"trace[662505766] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"119.312413ms","start":"2026-10-14T13:37:06.752649Z","end":"2026-10-14T13:37:06.871961Z","steps":["trace[662505766] 'process raft request' (duration: 118.920732ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:37:07.098304Z","caller":"traceutil/trace.go:171","msg":"trace[1230457385] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"222.16539ms","start":"2026-10-14T13:37:06.876104Z","end":"2026-10-14T13:37:07.09827Z","steps":["trace[1230457385] 'process raft request' (duration: 141.422528ms)","trace[1230457385] 'compare' (duration: 80.507135ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:37:07.098472Z","caller":"traceutil/trace.go:171","msg":"trace[756402434] linearizableReadLoop","detail":"{readStateIndex:1950; appliedIndex:1948; }","duration":"167.620775ms","start":"2026-10-14T13:37:06.930829Z","end":"2026-10-14T13:37:07.09845Z","steps":["trace[756402434] 'read index received' (duration: 86.80066ms)","trace[756402434] 'applied index is now lower than readState.Index' (duration: 80.818515ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:37:07.098573Z","caller":"traceutil/trace.go:171","msg":"trace[129924468] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"222.194541ms","start":"2026-10-14T13:37:06.876368Z","end":"2026-10-14T13:37:07.098562Z","steps":["trace[129924468] 'process raft request' (duration: 221.850571ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:37:07.09874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.897823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T13:37:07.098784Z","caller":"traceutil/trace.go:171","msg":"trace[1139388806] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:1875; }","duration":"168.012576ms","start":"2026-10-14T13:37:06.930758Z","end":"2026-10-14T13:37:07.098771Z","steps":["trace[1139388806] 'agreement among raft nodes before linearized reading' (duration: 167.927903ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:37:19.856532Z","caller":"traceutil/trace.go:171","msg":"trace[521089754] transaction","detail":"{read_only:false; response_revision:1984; number_of_response:1; }","duration":"114.056047ms","start":"2026-10-14T13:37:19.742456Z","end":"2026-10-14T13:37:19.856512Z","steps":["trace[521089754] 'process raft request' (duration: 113.942884ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:37:20.193324Z","caller":"traceutil/trace.go:171","msg":"trace[942936653] transaction","detail":"{read_only:false; response_revision:1989; number_of_response:1; }","duration":"146.359184ms","start":"2026-10-14T13:37:20.04693Z","end":"2026-10-14T13:37:20.193289Z","steps":["trace[942936653] 'process raft request' (duration: 146.104237ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:37:20.193316Z","caller":"traceutil/trace.go:171","msg":"trace[764523929] transaction","detail":"{read_only:false; response_revision:1988; number_of_response:1; }","duration":"146.299033ms","start":"2026-10-14T13:37:20.046914Z","end":"2026-10-14T13:37:20.193213Z","steps":["trace[764523929] 'process raft request' (duration: 145.964594ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:37:20.193686Z","caller":"traceutil/trace.go:171","msg":"trace[1489210268] transaction","detail":"{read_only:false; response_revision:1990; number_of_response:1; }","duration":"144.299706ms","start":"2026-10-14T13:37:20.049364Z","end":"2026-10-14T13:37:20.193664Z","steps":["trace[1489210268] 'process raft request' (duration: 143.744411ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:37:23.264724Z","caller":"traceutil/trace.go:171","msg":"trace[2101967284] linearizableReadLoop","detail":"{readStateIndex:2086; appliedIndex:2085; }","duration":"215.266918ms","start":"2026-10-14T13:37:23.049433Z","end":"2026-10-14T13:37:23.2647Z","steps":["trace[2101967284] 'read index received' (duration: 215.215556ms)","trace[2101967284] 'applied index is now lower than readState.Index' (duration: 35.961µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:37:23.264832Z","caller":"traceutil/trace.go:171","msg":"trace[226610219] transaction","detail":"{read_only:false; response_revision:2008; number_of_response:1; }","duration":"300.303649ms","start":"2026-10-14T13:37:22.964518Z","end":"2026-10-14T13:37:23.264822Z","steps":["trace[226610219] 'process raft request' (duration: 300.001971ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:37:23.265125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.656438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-14T13:37:23.265258Z","caller":"traceutil/trace.go:171","msg":"trace[846452877] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:2008; }","duration":"215.860305ms","start":"2026-10-14T13:37:23.049373Z","end":"2026-10-14T13:37:23.265233Z","steps":["trace[846452877] 'agreement among raft nodes before linearized reading' (duration: 215.659249ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:37:23.265417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:37:22.9645Z","time spent":"300.3561ms","remote":"127.0.0.1:59156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T13:37:23.268238Z","caller":"traceutil/trace.go:171","msg":"trace[1338896359] transaction","detail":"{read_only:false; response_revision:2009; number_of_response:1; }","duration":"104.339718ms","start":"2026-10-14T13:37:23.16388Z","end":"2026-10-14T13:37:23.26822Z","steps":["trace[1338896359] 'process raft request' (duration: 104.07053ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:38:02.880839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.088019ms","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-14T13:38:02.881033Z","caller":"traceutil/trace.go:171","msg":"trace[725755491] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:2225; }","duration":"178.366627ms","start":"2026-10-14T13:38:02.702643Z","end":"2026-10-14T13:38:02.88101Z","steps":["trace[725755491] 'count revisions from in-memory index tree' (duration: 177.947075ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:38:37.814339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.751918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-10-14T13:38:37.814433Z","caller":"traceutil/trace.go:171","msg":"trace[945826520] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2590; }","duration":"114.884081ms","start":"2026-10-14T13:38:37.699532Z","end":"2026-10-14T13:38:37.814416Z","steps":["trace[945826520] 'range keys from in-memory index tree' (duration: 114.588663ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:38:37.814584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.920762ms","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-10-14T13:38:37.814664Z","caller":"traceutil/trace.go:171","msg":"trace[312276006] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2590; }","duration":"115.020205ms","start":"2026-10-14T13:38:37.699626Z","end":"2026-10-14T13:38:37.814646Z","steps":["trace[312276006] 'range keys from in-memory index tree' (duration: 114.788639ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:38:37.814789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.959946ms","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-14T13:38:37.814827Z","caller":"traceutil/trace.go:171","msg":"trace[1678370552] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2590; }","duration":"189.028268ms","start":"2026-10-14T13:38:37.62579Z","end":"2026-10-14T13:38:37.814818Z","steps":["trace[1678370552] 'range keys from in-memory index tree' (duration: 188.862524ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:38:37.814922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.223213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-10-14T13:38:37.81496Z","caller":"traceutil/trace.go:171","msg":"trace[1850823681] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2590; }","duration":"110.258994ms","start":"2026-10-14T13:38:37.70469Z","end":"2026-10-14T13:38:37.814949Z","steps":["trace[1850823681] 'range keys from in-memory index tree' (duration: 110.145871ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:39:11.092027Z","caller":"traceutil/trace.go:171","msg":"trace[2140778032] transaction","detail":"{read_only:false; response_revision:2792; number_of_response:1; }","duration":"273.337233ms","start":"2026-10-14T13:39:10.818661Z","end":"2026-10-14T13:39:11.091998Z","steps":["trace[2140778032] 'process raft request' (duration: 273.169758ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:39:11.094286Z","caller":"traceutil/trace.go:171","msg":"trace[1785739025] transaction","detail":"{read_only:false; response_revision:2793; number_of_response:1; }","duration":"200.483219ms","start":"2026-10-14T13:39:10.893783Z","end":"2026-10-14T13:39:11.094266Z","steps":["trace[1785739025] 'process raft request' (duration: 200.362116ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:42:17.957143Z","caller":"traceutil/trace.go:171","msg":"trace[209247753] linearizableReadLoop","detail":"{readStateIndex:4136; appliedIndex:4135; }","duration":"133.876259ms","start":"2026-10-14T13:42:17.823242Z","end":"2026-10-14T13:42:17.957118Z","steps":["trace[209247753] 'read index received' (duration: 133.754706ms)","trace[209247753] 'applied index is now lower than readState.Index' (duration: 120.453µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:42:17.957235Z","caller":"traceutil/trace.go:171","msg":"trace[1504917773] transaction","detail":"{read_only:false; response_revision:3983; number_of_response:1; }","duration":"170.011579ms","start":"2026-10-14T13:42:17.787169Z","end":"2026-10-14T13:42:17.957181Z","steps":["trace[1504917773] 'process raft request' (duration: 169.806023ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:42:17.957425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.165806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-prometheus-client-secret\" ","response":"range_response_count:1 size:692"} {"level":"info","ts":"2026-10-14T13:42:17.957494Z","caller":"traceutil/trace.go:171","msg":"trace[488667250] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-prometheus-client-secret; range_end:; response_count:1; response_revision:3983; }","duration":"134.337262ms","start":"2026-10-14T13:42:17.823137Z","end":"2026-10-14T13:42:17.957474Z","steps":["trace[488667250] 'agreement among raft nodes before linearized reading' (duration: 134.106955ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:43:45.875318Z","caller":"traceutil/trace.go:171","msg":"trace[1622508633] transaction","detail":"{read_only:false; response_revision:5053; number_of_response:1; }","duration":"138.056687ms","start":"2026-10-14T13:43:45.737236Z","end":"2026-10-14T13:43:45.875293Z","steps":["trace[1622508633] 'process raft request' (duration: 119.289702ms)","trace[1622508633] 'compare' (duration: 18.652442ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T13:43:46.904128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.303068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-lvh8p\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-10-14T13:43:46.904263Z","caller":"traceutil/trace.go:171","msg":"trace[1310433948] range","detail":"{range_begin:/registry/pods/openstack/keepalived-lvh8p; range_end:; response_count:1; response_revision:5062; }","duration":"121.492203ms","start":"2026-10-14T13:43:46.782747Z","end":"2026-10-14T13:43:46.904239Z","steps":["trace[1310433948] 'range keys from in-memory index tree' (duration: 121.104563ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:43:46.909341Z","caller":"traceutil/trace.go:171","msg":"trace[1426276707] transaction","detail":"{read_only:false; response_revision:5063; number_of_response:1; }","duration":"101.485274ms","start":"2026-10-14T13:43:46.80783Z","end":"2026-10-14T13:43:46.909315Z","steps":["trace[1426276707] 'process raft request' (duration: 101.114354ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:43:48.509166Z","caller":"traceutil/trace.go:171","msg":"trace[1067065648] linearizableReadLoop","detail":"{readStateIndex:5368; appliedIndex:5367; }","duration":"178.187958ms","start":"2026-10-14T13:43:48.330948Z","end":"2026-10-14T13:43:48.509136Z","steps":["trace[1067065648] 'read index received' (duration: 145.46846ms)","trace[1067065648] 'applied index is now lower than readState.Index' (duration: 32.718288ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:43:48.509227Z","caller":"traceutil/trace.go:171","msg":"trace[1942672964] transaction","detail":"{read_only:false; response_revision:5171; number_of_response:1; }","duration":"219.397359ms","start":"2026-10-14T13:43:48.289766Z","end":"2026-10-14T13:43:48.509163Z","steps":["trace[1942672964] 'process raft request' (duration: 186.63666ms)","trace[1942672964] 'compare' (duration: 32.604704ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T13:43:48.509309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.353823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T13:43:48.509391Z","caller":"traceutil/trace.go:171","msg":"trace[660897922] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:5171; }","duration":"178.490736ms","start":"2026-10-14T13:43:48.330884Z","end":"2026-10-14T13:43:48.509374Z","steps":["trace[660897922] 'agreement among raft nodes before linearized reading' (duration: 178.362053ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:43:48.56314Z","caller":"traceutil/trace.go:171","msg":"trace[395287124] transaction","detail":"{read_only:false; response_revision:5172; number_of_response:1; }","duration":"214.00906ms","start":"2026-10-14T13:43:48.349106Z","end":"2026-10-14T13:43:48.563115Z","steps":["trace[395287124] 'process raft request' (duration: 213.880267ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:43:52.974541Z","caller":"traceutil/trace.go:171","msg":"trace[1274183255] transaction","detail":"{read_only:false; response_revision:5269; number_of_response:1; }","duration":"145.380168ms","start":"2026-10-14T13:43:52.829135Z","end":"2026-10-14T13:43:52.974515Z","steps":["trace[1274183255] 'process raft request' (duration: 145.155482ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:44:03.894883Z","caller":"traceutil/trace.go:171","msg":"trace[256746098] transaction","detail":"{read_only:false; response_revision:5446; number_of_response:1; }","duration":"122.383057ms","start":"2026-10-14T13:44:03.772459Z","end":"2026-10-14T13:44:03.894842Z","steps":["trace[256746098] 'process raft request' (duration: 79.789868ms)","trace[256746098] 'compare' (duration: 42.28869ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:44:04.145416Z","caller":"traceutil/trace.go:171","msg":"trace[1547623784] transaction","detail":"{read_only:false; response_revision:5448; number_of_response:1; }","duration":"245.31616ms","start":"2026-10-14T13:44:03.900079Z","end":"2026-10-14T13:44:04.145395Z","steps":["trace[1547623784] 'process raft request' (duration: 165.86881ms)","trace[1547623784] 'compare' (duration: 79.06832ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:44:04.145632Z","caller":"traceutil/trace.go:171","msg":"trace[1474816947] transaction","detail":"{read_only:false; response_revision:5450; number_of_response:1; }","duration":"243.755467ms","start":"2026-10-14T13:44:03.901871Z","end":"2026-10-14T13:44:04.145626Z","steps":["trace[1474816947] 'process raft request' (duration: 243.347325ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:44:04.145714Z","caller":"traceutil/trace.go:171","msg":"trace[809301506] transaction","detail":"{read_only:false; response_revision:5449; number_of_response:1; }","duration":"244.22308ms","start":"2026-10-14T13:44:03.901486Z","end":"2026-10-14T13:44:04.145709Z","steps":["trace[809301506] 'process raft request' (duration: 243.648374ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:44:04.145917Z","caller":"traceutil/trace.go:171","msg":"trace[428056893] transaction","detail":"{read_only:false; response_revision:5451; number_of_response:1; }","duration":"244.018974ms","start":"2026-10-14T13:44:03.901892Z","end":"2026-10-14T13:44:04.145911Z","steps":["trace[428056893] 'process raft request' (duration: 243.375737ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:44:04.146052Z","caller":"traceutil/trace.go:171","msg":"trace[1854826800] transaction","detail":"{read_only:false; response_revision:5452; number_of_response:1; }","duration":"241.795763ms","start":"2026-10-14T13:44:03.904216Z","end":"2026-10-14T13:44:04.146012Z","steps":["trace[1854826800] 'process raft request' (duration: 241.088484ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:44:04.146173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.791114ms","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-14T13:44:04.146403Z","caller":"traceutil/trace.go:171","msg":"trace[711882279] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5452; }","duration":"156.086352ms","start":"2026-10-14T13:44:03.990309Z","end":"2026-10-14T13:44:04.146396Z","steps":["trace[711882279] 'agreement among raft nodes before linearized reading' (duration: 155.781693ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:44:04.146548Z","caller":"traceutil/trace.go:171","msg":"trace[1866900017] linearizableReadLoop","detail":"{readStateIndex:5659; appliedIndex:5654; }","duration":"154.973722ms","start":"2026-10-14T13:44:03.99037Z","end":"2026-10-14T13:44:04.145344Z","steps":["trace[1866900017] 'read index received' (duration: 75.530062ms)","trace[1866900017] 'applied index is now lower than readState.Index' (duration: 79.44252ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:44:11.831436Z","caller":"traceutil/trace.go:171","msg":"trace[1946397648] transaction","detail":"{read_only:false; response_revision:5585; number_of_response:1; }","duration":"111.054267ms","start":"2026-10-14T13:44:11.720361Z","end":"2026-10-14T13:44:11.831415Z","steps":["trace[1946397648] 'process raft request' (duration: 110.809371ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:44:11.87103Z","caller":"traceutil/trace.go:171","msg":"trace[2136720710] transaction","detail":"{read_only:false; response_revision:5586; number_of_response:1; }","duration":"136.192057ms","start":"2026-10-14T13:44:11.734814Z","end":"2026-10-14T13:44:11.871006Z","steps":["trace[2136720710] 'process raft request' (duration: 135.960931ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:44:12.20835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.465687ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-14T13:44:12.20869Z","caller":"traceutil/trace.go:171","msg":"trace[1299945772] transaction","detail":"{read_only:false; number_of_response:1; response_revision:5588; }","duration":"330.816007ms","start":"2026-10-14T13:44:11.877857Z","end":"2026-10-14T13:44:12.208673Z","steps":["trace[1299945772] 'process raft request' (duration: 330.768646ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:44:12.208808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:44:11.877837Z","time spent":"330.92443ms","remote":"127.0.0.1:56146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":103,"response count":0,"response size":1751,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T13:44:12.208852Z","caller":"traceutil/trace.go:171","msg":"trace[1598616425] transaction","detail":"{read_only:false; response_revision:5587; number_of_response:1; }","duration":"373.457517ms","start":"2026-10-14T13:44:11.835366Z","end":"2026-10-14T13:44:12.208824Z","steps":["trace[1598616425] 'process raft request' (duration: 69.217509ms)","trace[1598616425] 'compare' (duration: 302.515341ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T13:44:12.208928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:44:11.835346Z","time spent":"373.55326ms","remote":"127.0.0.1:59002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":842,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-14T13:44:12.209082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.178524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3392b72e-6310-47ec-bb2a-18f87cbf816e\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-10-14T13:44:12.209133Z","caller":"traceutil/trace.go:171","msg":"trace[502908183] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-3392b72e-6310-47ec-bb2a-18f87cbf816e; range_end:; response_count:1; response_revision:5588; }","duration":"383.275787ms","start":"2026-10-14T13:44:11.825842Z","end":"2026-10-14T13:44:12.209118Z","steps":["trace[502908183] 'agreement among raft nodes before linearized reading' (duration: 382.881666ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:44:12.20867Z","caller":"traceutil/trace.go:171","msg":"trace[985760315] linearizableReadLoop","detail":"{readStateIndex:5796; appliedIndex:5795; }","duration":"337.771808ms","start":"2026-10-14T13:44:11.870868Z","end":"2026-10-14T13:44:12.20864Z","steps":["trace[985760315] 'read index received' (duration: 33.653383ms)","trace[985760315] 'applied index is now lower than readState.Index' (duration: 304.115425ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T13:44:12.209264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:44:11.825822Z","time spent":"383.430621ms","remote":"127.0.0.1:59068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3668,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3392b72e-6310-47ec-bb2a-18f87cbf816e\" "} {"level":"info","ts":"2026-10-14T13:44:12.209317Z","caller":"traceutil/trace.go:171","msg":"trace[2069651868] transaction","detail":"{read_only:false; response_revision:5588; number_of_response:1; }","duration":"331.695671ms","start":"2026-10-14T13:44:11.877611Z","end":"2026-10-14T13:44:12.209307Z","steps":["trace[2069651868] 'process raft request' (duration: 330.91766ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:44:12.20945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:44:11.877592Z","time spent":"331.771994ms","remote":"127.0.0.1:56146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1702,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T13:44:12.209919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.480595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" ","response":"range_response_count:1 size:1717"} {"level":"info","ts":"2026-10-14T13:44:12.209958Z","caller":"traceutil/trace.go:171","msg":"trace[559172367] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls; range_end:; response_count:1; response_revision:5589; }","duration":"335.559167ms","start":"2026-10-14T13:44:11.874389Z","end":"2026-10-14T13:44:12.209948Z","steps":["trace[559172367] 'agreement among raft nodes before linearized reading' (duration: 335.480285ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:44:12.210004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:44:11.874367Z","time spent":"335.629529ms","remote":"127.0.0.1:56146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":1,"response size":1740,"request content":"key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" "} {"level":"info","ts":"2026-10-14T13:44:12.210318Z","caller":"traceutil/trace.go:171","msg":"trace[371242350] transaction","detail":"{read_only:false; response_revision:5589; number_of_response:1; }","duration":"215.447251ms","start":"2026-10-14T13:44:11.994849Z","end":"2026-10-14T13:44:12.210297Z","steps":["trace[371242350] 'process raft request' (duration: 214.915457ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:44:12.210331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.514384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secrettemplates/\" range_end:\"/registry/secretgen.carvel.dev/secrettemplates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-14T13:44:12.210357Z","caller":"traceutil/trace.go:171","msg":"trace[1820474420] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secrettemplates/; range_end:/registry/secretgen.carvel.dev/secrettemplates0; response_count:0; response_revision:5589; }","duration":"168.546115ms","start":"2026-10-14T13:44:12.041803Z","end":"2026-10-14T13:44:12.210349Z","steps":["trace[1820474420] 'agreement among raft nodes before linearized reading' (duration: 168.494773ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:44:12.210512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.254856ms","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-14T13:44:12.210535Z","caller":"traceutil/trace.go:171","msg":"trace[12781113] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5589; }","duration":"258.312058ms","start":"2026-10-14T13:44:11.952216Z","end":"2026-10-14T13:44:12.210528Z","steps":["trace[12781113] 'agreement among raft nodes before linearized reading' (duration: 258.238576ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:44:12.532033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.787111ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T13:44:12.532348Z","caller":"traceutil/trace.go:171","msg":"trace[146798956] linearizableReadLoop","detail":"{readStateIndex:5800; appliedIndex:5799; }","duration":"313.910913ms","start":"2026-10-14T13:44:12.218408Z","end":"2026-10-14T13:44:12.532319Z","steps":["trace[146798956] 'read index received' (duration: 101.842394ms)","trace[146798956] 'applied index is now lower than readState.Index' (duration: 212.064859ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:44:12.532394Z","caller":"traceutil/trace.go:171","msg":"trace[1822123186] transaction","detail":"{read_only:false; response_revision:5591; number_of_response:1; }","duration":"313.900603ms","start":"2026-10-14T13:44:12.218477Z","end":"2026-10-14T13:44:12.532378Z","steps":["trace[1822123186] 'process raft request' (duration: 313.662897ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:44:12.532418Z","caller":"traceutil/trace.go:171","msg":"trace[2074195312] transaction","detail":"{read_only:false; response_revision:5590; number_of_response:1; }","duration":"314.025317ms","start":"2026-10-14T13:44:12.218359Z","end":"2026-10-14T13:44:12.532384Z","steps":["trace[2074195312] 'process raft request' (duration: 101.798784ms)","trace[2074195312] 'compare' (duration: 211.560535ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T13:44:12.532461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:44:12.218471Z","time spent":"313.957004ms","remote":"127.0.0.1:59156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T13:44:12.532447Z","caller":"traceutil/trace.go:171","msg":"trace[1248917771] transaction","detail":"{read_only:false; response_revision:5592; number_of_response:1; }","duration":"313.903233ms","start":"2026-10-14T13:44:12.218518Z","end":"2026-10-14T13:44:12.532421Z","steps":["trace[1248917771] 'process raft request' (duration: 313.727708ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:44:12.532555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:44:12.218332Z","time spent":"314.14645ms","remote":"127.0.0.1:59068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3747,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T13:44:12.532549Z","caller":"traceutil/trace.go:171","msg":"trace[1950533635] transaction","detail":"{read_only:false; response_revision:5593; number_of_response:1; }","duration":"310.839489ms","start":"2026-10-14T13:44:12.22168Z","end":"2026-10-14T13:44:12.532519Z","steps":["trace[1950533635] 'process raft request' (duration: 310.601412ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:44:12.532593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:44:12.218513Z","time spent":"313.990446ms","remote":"127.0.0.1:59156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T13:44:12.532611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.194191ms","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-10-14T13:44:12.532662Z","caller":"traceutil/trace.go:171","msg":"trace[1299719655] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5594; }","duration":"314.265973ms","start":"2026-10-14T13:44:12.21838Z","end":"2026-10-14T13:44:12.532646Z","steps":["trace[1299719655] 'agreement among raft nodes before linearized reading' (duration: 314.088679ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:44:12.532681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:44:12.221656Z","time spent":"310.958723ms","remote":"127.0.0.1:59002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":840,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-14T13:44:12.532704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:44:12.218373Z","time spent":"314.319865ms","remote":"127.0.0.1:59156","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-10-14T13:44:12.532745Z","caller":"traceutil/trace.go:171","msg":"trace[636151566] transaction","detail":"{read_only:false; response_revision:5594; number_of_response:1; }","duration":"309.939675ms","start":"2026-10-14T13:44:12.222789Z","end":"2026-10-14T13:44:12.532729Z","steps":["trace[636151566] 'process raft request' (duration: 309.542274ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:44:12.532784Z","caller":"traceutil/trace.go:171","msg":"trace[1640958300] transaction","detail":"{read_only:false; response_revision:5595; number_of_response:1; }","duration":"243.666066ms","start":"2026-10-14T13:44:12.289074Z","end":"2026-10-14T13:44:12.53274Z","steps":["trace[1640958300] 'process raft request' (duration: 243.4643ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:44:12.532832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:44:12.222779Z","time spent":"309.998026ms","remote":"127.0.0.1:56146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2250,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T13:44:12.532871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.226616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T13:44:12.532934Z","caller":"traceutil/trace.go:171","msg":"trace[178816567] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:5595; }","duration":"215.341279ms","start":"2026-10-14T13:44:12.317576Z","end":"2026-10-14T13:44:12.532917Z","steps":["trace[178816567] 'agreement among raft nodes before linearized reading' (duration: 215.226266ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:44:12.532934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.641566ms","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-14T13:44:12.533012Z","caller":"traceutil/trace.go:171","msg":"trace[1193535005] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5595; }","duration":"309.75695ms","start":"2026-10-14T13:44:12.223235Z","end":"2026-10-14T13:44:12.532992Z","steps":["trace[1193535005] 'agreement among raft nodes before linearized reading' (duration: 309.460162ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:44:12.533052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:44:12.223218Z","time spent":"309.825951ms","remote":"127.0.0.1:59156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-10-14T13:44:19.092457Z","caller":"traceutil/trace.go:171","msg":"trace[2014068402] transaction","detail":"{read_only:false; response_revision:5704; number_of_response:1; }","duration":"142.8904ms","start":"2026-10-14T13:44:18.949543Z","end":"2026-10-14T13:44:19.092434Z","steps":["trace[2014068402] 'process raft request' (duration: 142.708115ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:44:19.092455Z","caller":"traceutil/trace.go:171","msg":"trace[139015227] transaction","detail":"{read_only:false; response_revision:5703; number_of_response:1; }","duration":"143.014214ms","start":"2026-10-14T13:44:18.949394Z","end":"2026-10-14T13:44:19.092408Z","steps":["trace[139015227] 'process raft request' (duration: 56.373366ms)","trace[139015227] 'compare' (duration: 86.286028ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:44:19.092515Z","caller":"traceutil/trace.go:171","msg":"trace[430254755] transaction","detail":"{read_only:false; response_revision:5705; number_of_response:1; }","duration":"142.928492ms","start":"2026-10-14T13:44:18.949559Z","end":"2026-10-14T13:44:19.092488Z","steps":["trace[430254755] 'process raft request' (duration: 142.771298ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:44:19.092808Z","caller":"traceutil/trace.go:171","msg":"trace[610908294] transaction","detail":"{read_only:false; response_revision:5706; number_of_response:1; }","duration":"142.644934ms","start":"2026-10-14T13:44:18.95012Z","end":"2026-10-14T13:44:19.092765Z","steps":["trace[610908294] 'process raft request' (duration: 142.258793ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:44:19.092897Z","caller":"traceutil/trace.go:171","msg":"trace[1477551136] transaction","detail":"{read_only:false; response_revision:5707; number_of_response:1; }","duration":"140.243378ms","start":"2026-10-14T13:44:18.952639Z","end":"2026-10-14T13:44:19.092883Z","steps":["trace[1477551136] 'process raft request' (duration: 139.95573ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:44:19.092947Z","caller":"traceutil/trace.go:171","msg":"trace[2135253500] transaction","detail":"{read_only:false; response_revision:5708; number_of_response:1; }","duration":"139.916849ms","start":"2026-10-14T13:44:18.953001Z","end":"2026-10-14T13:44:19.092918Z","steps":["trace[2135253500] 'process raft request' (duration: 139.765325ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:44:25.697839Z","caller":"traceutil/trace.go:171","msg":"trace[1799154140] linearizableReadLoop","detail":"{readStateIndex:5984; appliedIndex:5983; }","duration":"148.566047ms","start":"2026-10-14T13:44:25.549248Z","end":"2026-10-14T13:44:25.697814Z","steps":["trace[1799154140] 'read index received' (duration: 148.341301ms)","trace[1799154140] 'applied index is now lower than readState.Index' (duration: 223.266µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:44:25.698122Z","caller":"traceutil/trace.go:171","msg":"trace[30076533] transaction","detail":"{read_only:false; response_revision:5770; number_of_response:1; }","duration":"182.58803ms","start":"2026-10-14T13:44:25.515521Z","end":"2026-10-14T13:44:25.698109Z","steps":["trace[30076533] 'process raft request' (duration: 182.130497ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:44:25.698307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.045399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-10-14T13:44:25.698379Z","caller":"traceutil/trace.go:171","msg":"trace[1214535092] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5770; }","duration":"149.204794ms","start":"2026-10-14T13:44:25.549156Z","end":"2026-10-14T13:44:25.698361Z","steps":["trace[1214535092] 'agreement among raft nodes before linearized reading' (duration: 148.975177ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:44:25.941905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.886742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-14T13:44:25.942026Z","caller":"traceutil/trace.go:171","msg":"trace[1888100339] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5770; }","duration":"166.085377ms","start":"2026-10-14T13:44:25.775916Z","end":"2026-10-14T13:44:25.942001Z","steps":["trace[1888100339] 'count revisions from in-memory index tree' (duration: 165.792679ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:44:25.942043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.158166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T13:44:25.942121Z","caller":"traceutil/trace.go:171","msg":"trace[1068609748] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5770; }","duration":"163.26628ms","start":"2026-10-14T13:44:25.778835Z","end":"2026-10-14T13:44:25.942101Z","steps":["trace[1068609748] 'range keys from in-memory index tree' (duration: 163.068114ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:44:42.583433Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2969} {"level":"info","ts":"2026-10-14T13:44:42.663514Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2969,"took":"78.602816ms","hash":812473895,"current-db-size-bytes":56582144,"current-db-size":"57 MB","current-db-size-in-use-bytes":32468992,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-14T13:44:42.663584Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":812473895,"revision":2969,"compact-revision":-1} {"level":"info","ts":"2026-10-14T13:49:04.302839Z","caller":"traceutil/trace.go:171","msg":"trace[594711209] transaction","detail":"{read_only:false; response_revision:7773; number_of_response:1; }","duration":"117.423512ms","start":"2026-10-14T13:49:04.185385Z","end":"2026-10-14T13:49:04.302809Z","steps":["trace[594711209] 'process raft request' (duration: 117.362881ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:49:04.302874Z","caller":"traceutil/trace.go:171","msg":"trace[1215025654] transaction","detail":"{read_only:false; response_revision:7772; number_of_response:1; }","duration":"117.35067ms","start":"2026-10-14T13:49:04.185488Z","end":"2026-10-14T13:49:04.302839Z","steps":["trace[1215025654] 'process raft request' (duration: 117.097423ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:49:42.593195Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5884} {"level":"info","ts":"2026-10-14T13:49:42.694099Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5884,"took":"99.409921ms","hash":3640391585,"current-db-size-bytes":56582144,"current-db-size":"57 MB","current-db-size-in-use-bytes":25632768,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-14T13:49:42.694212Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3640391585,"revision":5884,"compact-revision":2969} {"level":"info","ts":"2026-10-14T13:50:48.820171Z","caller":"traceutil/trace.go:171","msg":"trace[833575771] transaction","detail":"{read_only:false; response_revision:8603; number_of_response:1; }","duration":"115.561106ms","start":"2026-10-14T13:50:48.70456Z","end":"2026-10-14T13:50:48.820121Z","steps":["trace[833575771] 'process raft request' (duration: 115.34257ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:50:49.14928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.036969ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T13:50:49.149409Z","caller":"traceutil/trace.go:171","msg":"trace[424888957] transaction","detail":"{read_only:false; response_revision:8604; number_of_response:1; }","duration":"313.387448ms","start":"2026-10-14T13:50:48.835998Z","end":"2026-10-14T13:50:49.149386Z","steps":["trace[424888957] 'process raft request' (duration: 145.104403ms)","trace[424888957] 'compare' (duration: 167.631717ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T13:50:49.149488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:50:48.835976Z","time spent":"313.47026ms","remote":"127.0.0.1:59156","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-10-14T13:50:49.152455Z","caller":"traceutil/trace.go:171","msg":"trace[1808683643] linearizableReadLoop","detail":"{readStateIndex:8914; appliedIndex:8912; }","duration":"308.218237ms","start":"2026-10-14T13:50:48.844215Z","end":"2026-10-14T13:50:49.152433Z","steps":["trace[1808683643] 'read index received' (duration: 136.899849ms)","trace[1808683643] 'applied index is now lower than readState.Index' (duration: 171.317128ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:50:49.152534Z","caller":"traceutil/trace.go:171","msg":"trace[509219136] transaction","detail":"{read_only:false; response_revision:8605; number_of_response:1; }","duration":"314.744675ms","start":"2026-10-14T13:50:48.837768Z","end":"2026-10-14T13:50:49.152513Z","steps":["trace[509219136] 'process raft request' (duration: 314.56397ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:50:49.152641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:50:48.837752Z","time spent":"314.834777ms","remote":"127.0.0.1:59156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T13:50:49.152691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.527203ms","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-14T13:50:49.15274Z","caller":"traceutil/trace.go:171","msg":"trace[1672967193] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8605; }","duration":"294.623885ms","start":"2026-10-14T13:50:48.858102Z","end":"2026-10-14T13:50:49.152726Z","steps":["trace[1672967193] 'agreement among raft nodes before linearized reading' (duration: 294.45512ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:50:49.152709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.435773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-14T13:50:49.152807Z","caller":"traceutil/trace.go:171","msg":"trace[2145520616] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:8605; }","duration":"308.611748ms","start":"2026-10-14T13:50:48.844174Z","end":"2026-10-14T13:50:49.152785Z","steps":["trace[2145520616] 'agreement among raft nodes before linearized reading' (duration: 308.368771ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:50:49.152811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.228856ms","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-14T13:50:49.152862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:50:48.844158Z","time spent":"308.692919ms","remote":"127.0.0.1:59252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":30,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"info","ts":"2026-10-14T13:50:49.152891Z","caller":"traceutil/trace.go:171","msg":"trace[108520077] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8605; }","duration":"249.36557ms","start":"2026-10-14T13:50:48.903505Z","end":"2026-10-14T13:50:49.15287Z","steps":["trace[108520077] 'agreement among raft nodes before linearized reading' (duration: 249.110473ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:50:50.455082Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000022d9.wal"} {"level":"info","ts":"2026-10-14T13:50:59.384049Z","caller":"traceutil/trace.go:171","msg":"trace[265386894] transaction","detail":"{read_only:false; response_revision:8661; number_of_response:1; }","duration":"145.451532ms","start":"2026-10-14T13:50:59.238572Z","end":"2026-10-14T13:50:59.384024Z","steps":["trace[265386894] 'process raft request' (duration: 59.529815ms)","trace[265386894] 'compare' (duration: 85.67769ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:50:59.38422Z","caller":"traceutil/trace.go:171","msg":"trace[796051696] transaction","detail":"{read_only:false; response_revision:8662; number_of_response:1; }","duration":"122.873675ms","start":"2026-10-14T13:50:59.261305Z","end":"2026-10-14T13:50:59.384179Z","steps":["trace[796051696] 'process raft request' (duration: 122.597888ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:51:00.638694Z","caller":"traceutil/trace.go:171","msg":"trace[600381696] transaction","detail":"{read_only:false; response_revision:8665; number_of_response:1; }","duration":"146.941032ms","start":"2026-10-14T13:51:00.491725Z","end":"2026-10-14T13:51:00.638666Z","steps":["trace[600381696] 'process raft request' (duration: 146.762257ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:51:01.269892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.48787ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-10-14T13:51:01.270203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.775172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T13:51:01.270298Z","caller":"traceutil/trace.go:171","msg":"trace[1546701425] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8666; }","duration":"111.912975ms","start":"2026-10-14T13:51:01.158365Z","end":"2026-10-14T13:51:01.270278Z","steps":["trace[1546701425] 'agreement among raft nodes before linearized reading' (duration: 111.764341ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:51:01.270087Z","caller":"traceutil/trace.go:171","msg":"trace[71241981] linearizableReadLoop","detail":"{readStateIndex:8978; appliedIndex:8977; }","duration":"111.624287ms","start":"2026-10-14T13:51:01.158417Z","end":"2026-10-14T13:51:01.270041Z","steps":["trace[71241981] 'read index received' (duration: 45.691µs)","trace[71241981] 'applied index is now lower than readState.Index' (duration: 111.576626ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T13:51:01.271035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.20236ms","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":"info","ts":"2026-10-14T13:51:01.271617Z","caller":"traceutil/trace.go:171","msg":"trace[387908051] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:8666; }","duration":"102.333393ms","start":"2026-10-14T13:51:01.16875Z","end":"2026-10-14T13:51:01.271084Z","steps":["trace[387908051] 'agreement among raft nodes before linearized reading' (duration: 102.170499ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:51:01.522406Z","caller":"traceutil/trace.go:171","msg":"trace[121540136] transaction","detail":"{read_only:false; response_revision:8671; number_of_response:1; }","duration":"133.493635ms","start":"2026-10-14T13:51:01.388884Z","end":"2026-10-14T13:51:01.522378Z","steps":["trace[121540136] 'process raft request' (duration: 131.755628ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:52:49.569141Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b3aa5b67741e7c5e","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-14T13:52:49.578378Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-14T13:52:49.578536Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"warn","ts":"2026-10-14T13:53:10.36452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.208922ms","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-14T13:53:10.364621Z","caller":"traceutil/trace.go:171","msg":"trace[2131322788] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9791; }","duration":"302.367196ms","start":"2026-10-14T13:53:10.062234Z","end":"2026-10-14T13:53:10.364601Z","steps":["trace[2131322788] 'range keys from in-memory index tree' (duration: 302.009756ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:53:10.364609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.78376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-10-14T13:53:10.364609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.077057ms","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-10-14T13:53:10.364733Z","caller":"traceutil/trace.go:171","msg":"trace[1397995904] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9791; }","duration":"297.934355ms","start":"2026-10-14T13:53:10.066772Z","end":"2026-10-14T13:53:10.364706Z","steps":["trace[1397995904] 'range keys from in-memory index tree' (duration: 297.659237ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:53:10.364609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.650321ms","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-14T13:53:10.364866Z","caller":"traceutil/trace.go:171","msg":"trace[434505667] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9791; }","duration":"250.97395ms","start":"2026-10-14T13:53:10.113865Z","end":"2026-10-14T13:53:10.364839Z","steps":["trace[434505667] 'range keys from in-memory index tree' (duration: 250.392664ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:53:10.364666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:53:10.062211Z","time spent":"302.444488ms","remote":"127.0.0.1:59156","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-10-14T13:53:10.365282Z","caller":"traceutil/trace.go:171","msg":"trace[93288907] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9791; }","duration":"283.775667ms","start":"2026-10-14T13:53:10.081486Z","end":"2026-10-14T13:53:10.365262Z","steps":["trace[93288907] 'range keys from in-memory index tree' (duration: 282.900744ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:53:10.933266Z","caller":"traceutil/trace.go:171","msg":"trace[15959272] transaction","detail":"{read_only:false; response_revision:9797; number_of_response:1; }","duration":"145.721839ms","start":"2026-10-14T13:53:10.787525Z","end":"2026-10-14T13:53:10.933247Z","steps":["trace[15959272] 'process raft request' (duration: 145.618996ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:54:42.683352Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8044} {"level":"info","ts":"2026-10-14T13:54:42.826825Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8044,"took":"141.102352ms","hash":3979046308,"current-db-size-bytes":56582144,"current-db-size":"57 MB","current-db-size-in-use-bytes":28008448,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-14T13:54:42.826932Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3979046308,"revision":8044,"compact-revision":5884} {"level":"info","ts":"2026-10-14T13:57:22.436496Z","caller":"traceutil/trace.go:171","msg":"trace[112193495] transaction","detail":"{read_only:false; response_revision:11409; number_of_response:1; }","duration":"135.515937ms","start":"2026-10-14T13:57:22.30096Z","end":"2026-10-14T13:57:22.436476Z","steps":["trace[112193495] 'process raft request' (duration: 51.893014ms)","trace[112193495] 'compare' (duration: 83.4849ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T13:58:32.515632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.997906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/cinder-api\" ","response":"range_response_count:1 size:667"} {"level":"info","ts":"2026-10-14T13:58:32.51573Z","caller":"traceutil/trace.go:171","msg":"trace[1850779329] range","detail":"{range_begin:/registry/services/endpoints/openstack/cinder-api; range_end:; response_count:1; response_revision:12125; }","duration":"157.15258ms","start":"2026-10-14T13:58:32.358558Z","end":"2026-10-14T13:58:32.51571Z","steps":["trace[1850779329] 'range keys from in-memory index tree' (duration: 156.839532ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:58:32.516046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.966587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:1 size:5077"} {"level":"warn","ts":"2026-10-14T13:58:32.51611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.607472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T13:58:32.516175Z","caller":"traceutil/trace.go:171","msg":"trace[767490796] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:12125; }","duration":"156.106781ms","start":"2026-10-14T13:58:32.360025Z","end":"2026-10-14T13:58:32.516132Z","steps":["trace[767490796] 'range keys from in-memory index tree' (duration: 155.806734ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:58:32.516533Z","caller":"traceutil/trace.go:171","msg":"trace[1999796201] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:12125; }","duration":"157.701115ms","start":"2026-10-14T13:58:32.35846Z","end":"2026-10-14T13:58:32.516161Z","steps":["trace[1999796201] 'range keys from in-memory index tree' (duration: 157.564772ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:58:32.516674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.308129ms","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-14T13:58:32.516728Z","caller":"traceutil/trace.go:171","msg":"trace[925805399] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:12125; }","duration":"171.404691ms","start":"2026-10-14T13:58:32.345309Z","end":"2026-10-14T13:58:32.516714Z","steps":["trace[925805399] 'range keys from in-memory index tree' (duration: 171.159434ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:58:32.516708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.456647ms","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-10-14T13:58:32.516776Z","caller":"traceutil/trace.go:171","msg":"trace[37967297] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:12125; }","duration":"189.56178ms","start":"2026-10-14T13:58:32.327199Z","end":"2026-10-14T13:58:32.51676Z","steps":["trace[37967297] 'range keys from in-memory index tree' (duration: 189.300342ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:58:32.516828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.237079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-14T13:58:32.516813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.748304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T13:58:32.516931Z","caller":"traceutil/trace.go:171","msg":"trace[2079772032] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:12125; }","duration":"158.375674ms","start":"2026-10-14T13:58:32.358538Z","end":"2026-10-14T13:58:32.516913Z","steps":["trace[2079772032] 'range keys from in-memory index tree' (duration: 158.147378ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:58:32.51698Z","caller":"traceutil/trace.go:171","msg":"trace[2407151] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:12125; }","duration":"158.996301ms","start":"2026-10-14T13:58:32.357961Z","end":"2026-10-14T13:58:32.516957Z","steps":["trace[2407151] 'range keys from in-memory index tree' (duration: 158.59882ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:58:32.517126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.370563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T13:58:32.517171Z","caller":"traceutil/trace.go:171","msg":"trace[941214185] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:12125; }","duration":"158.635921ms","start":"2026-10-14T13:58:32.358524Z","end":"2026-10-14T13:58:32.51716Z","steps":["trace[941214185] 'range keys from in-memory index tree' (duration: 158.308262ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:58:32.522918Z","caller":"traceutil/trace.go:171","msg":"trace[1053939430] transaction","detail":"{read_only:false; response_revision:12126; number_of_response:1; }","duration":"155.808763ms","start":"2026-10-14T13:58:32.367084Z","end":"2026-10-14T13:58:32.522892Z","steps":["trace[1053939430] 'process raft request' (duration: 155.584617ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:58:54.756455Z","caller":"traceutil/trace.go:171","msg":"trace[1107408636] transaction","detail":"{read_only:false; response_revision:12250; number_of_response:1; }","duration":"152.992116ms","start":"2026-10-14T13:58:54.60343Z","end":"2026-10-14T13:58:54.756422Z","steps":["trace[1107408636] 'process raft request' (duration: 55.396689ms)","trace[1107408636] 'compare' (duration: 97.465693ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:58:54.756562Z","caller":"traceutil/trace.go:171","msg":"trace[1880625190] linearizableReadLoop","detail":"{readStateIndex:12678; appliedIndex:12677; }","duration":"131.075115ms","start":"2026-10-14T13:58:54.625347Z","end":"2026-10-14T13:58:54.756422Z","steps":["trace[1880625190] 'read index received' (duration: 33.417966ms)","trace[1880625190] 'applied index is now lower than readState.Index' (duration: 97.655669ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T13:58:54.756587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.2298ms","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-10-14T13:58:54.756669Z","caller":"traceutil/trace.go:171","msg":"trace[1259091435] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:12250; }","duration":"131.354023ms","start":"2026-10-14T13:58:54.625296Z","end":"2026-10-14T13:58:54.75665Z","steps":["trace[1259091435] 'agreement among raft nodes before linearized reading' (duration: 131.130497ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:58:54.804349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.734189ms","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-14T13:58:54.80443Z","caller":"traceutil/trace.go:171","msg":"trace[1881988694] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:12251; }","duration":"160.851932ms","start":"2026-10-14T13:58:54.643559Z","end":"2026-10-14T13:58:54.804411Z","steps":["trace[1881988694] 'agreement among raft nodes before linearized reading' (duration: 160.640566ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:58:54.804465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.767033ms","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-14T13:58:54.804763Z","caller":"traceutil/trace.go:171","msg":"trace[1602400977] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:12251; }","duration":"152.094871ms","start":"2026-10-14T13:58:54.652644Z","end":"2026-10-14T13:58:54.804739Z","steps":["trace[1602400977] 'agreement among raft nodes before linearized reading' (duration: 151.654129ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:58:54.994829Z","caller":"traceutil/trace.go:171","msg":"trace[1341580722] transaction","detail":"{read_only:false; response_revision:12253; number_of_response:1; }","duration":"183.688959ms","start":"2026-10-14T13:58:54.811118Z","end":"2026-10-14T13:58:54.994807Z","steps":["trace[1341580722] 'process raft request' (duration: 183.488873ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:58:54.994964Z","caller":"traceutil/trace.go:171","msg":"trace[796639631] transaction","detail":"{read_only:false; response_revision:12254; number_of_response:1; }","duration":"183.39834ms","start":"2026-10-14T13:58:54.811541Z","end":"2026-10-14T13:58:54.994939Z","steps":["trace[796639631] 'process raft request' (duration: 183.205165ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:58:55.013336Z","caller":"traceutil/trace.go:171","msg":"trace[871970213] transaction","detail":"{read_only:false; response_revision:12255; number_of_response:1; }","duration":"107.18518ms","start":"2026-10-14T13:58:54.906119Z","end":"2026-10-14T13:58:55.013304Z","steps":["trace[871970213] 'process raft request' (duration: 106.945963ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:58:56.192091Z","caller":"traceutil/trace.go:171","msg":"trace[1576766723] transaction","detail":"{read_only:false; response_revision:12256; number_of_response:1; }","duration":"677.005189ms","start":"2026-10-14T13:58:55.515054Z","end":"2026-10-14T13:58:56.192059Z","steps":["trace[1576766723] 'process raft request' (duration: 676.829604ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:58:56.192265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:58:55.515034Z","time spent":"677.141873ms","remote":"127.0.0.1:59156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T13:58:56.612788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.75779ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T13:58:56.613084Z","caller":"traceutil/trace.go:171","msg":"trace[828842253] transaction","detail":"{read_only:false; response_revision:12258; number_of_response:1; }","duration":"286.93652ms","start":"2026-10-14T13:58:56.326069Z","end":"2026-10-14T13:58:56.613005Z","steps":["trace[828842253] 'process raft request' (duration: 286.855528ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:58:56.61335Z","caller":"traceutil/trace.go:171","msg":"trace[1146055293] linearizableReadLoop","detail":"{readStateIndex:12685; appliedIndex:12683; }","duration":"644.157358ms","start":"2026-10-14T13:58:55.969173Z","end":"2026-10-14T13:58:56.61333Z","steps":["trace[1146055293] 'read index received' (duration: 222.668897ms)","trace[1146055293] 'applied index is now lower than readState.Index' (duration: 421.486161ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:58:56.613366Z","caller":"traceutil/trace.go:171","msg":"trace[1416150211] transaction","detail":"{read_only:false; response_revision:12257; number_of_response:1; }","duration":"1.048089577s","start":"2026-10-14T13:58:55.565239Z","end":"2026-10-14T13:58:56.613329Z","steps":["trace[1416150211] 'process raft request' (duration: 731.709129ms)","trace[1416150211] 'compare' (duration: 315.200035ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T13:58:56.613526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"644.352584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.31\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-10-14T13:58:56.613563Z","caller":"traceutil/trace.go:171","msg":"trace[787482990] range","detail":"{range_begin:/registry/masterleases/199.19.213.31; range_end:; response_count:1; response_revision:12258; }","duration":"644.395365ms","start":"2026-10-14T13:58:55.969158Z","end":"2026-10-14T13:58:56.613554Z","steps":["trace[787482990] 'agreement among raft nodes before linearized reading' (duration: 644.256001ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:58:56.613597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:58:55.969102Z","time spent":"644.482247ms","remote":"127.0.0.1:58952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.31\" "} {"level":"warn","ts":"2026-10-14T13:58:56.613621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:58:55.565214Z","time spent":"1.048225871s","remote":"127.0.0.1:59156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T13:58:56.801528Z","caller":"traceutil/trace.go:171","msg":"trace[821076054] linearizableReadLoop","detail":"{readStateIndex:12687; appliedIndex:12686; }","duration":"188.10951ms","start":"2026-10-14T13:58:56.613391Z","end":"2026-10-14T13:58:56.8015Z","steps":["trace[821076054] 'read index received' (duration: 125.278456ms)","trace[821076054] 'applied index is now lower than readState.Index' (duration: 62.828704ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T13:58:56.801736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.043984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-14T13:58:56.801781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.657152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-14T13:58:56.801816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.852916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T13:58:56.801826Z","caller":"traceutil/trace.go:171","msg":"trace[211579332] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:12259; }","duration":"228.177548ms","start":"2026-10-14T13:58:56.573631Z","end":"2026-10-14T13:58:56.801808Z","steps":["trace[211579332] 'agreement among raft nodes before linearized reading' (duration: 228.006074ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:58:56.801842Z","caller":"traceutil/trace.go:171","msg":"trace[77550868] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:12259; }","duration":"228.748164ms","start":"2026-10-14T13:58:56.573078Z","end":"2026-10-14T13:58:56.801826Z","steps":["trace[77550868] 'agreement among raft nodes before linearized reading' (duration: 228.629241ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:58:56.801873Z","caller":"traceutil/trace.go:171","msg":"trace[185011059] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:12259; }","duration":"228.917518ms","start":"2026-10-14T13:58:56.572924Z","end":"2026-10-14T13:58:56.801841Z","steps":["trace[185011059] 'agreement among raft nodes before linearized reading' (duration: 228.873797ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:58:56.801515Z","caller":"traceutil/trace.go:171","msg":"trace[533766827] transaction","detail":"{read_only:false; response_revision:12259; number_of_response:1; }","duration":"247.262322ms","start":"2026-10-14T13:58:56.554211Z","end":"2026-10-14T13:58:56.801474Z","steps":["trace[533766827] 'process raft request' (duration: 184.442609ms)","trace[533766827] 'compare' (duration: 62.626178ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T13:58:56.801959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.6608ms","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-14T13:58:56.802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.913665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:1 size:5077"} {"level":"info","ts":"2026-10-14T13:58:56.802012Z","caller":"traceutil/trace.go:171","msg":"trace[1886870939] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:12259; }","duration":"349.713562ms","start":"2026-10-14T13:58:56.452287Z","end":"2026-10-14T13:58:56.802001Z","steps":["trace[1886870939] 'agreement among raft nodes before linearized reading' (duration: 349.594598ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:58:56.801997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.381084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/cinder-api\" ","response":"range_response_count:1 size:667"} {"level":"warn","ts":"2026-10-14T13:58:56.80205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:58:56.452219Z","time spent":"349.822805ms","remote":"127.0.0.1:59156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-14T13:58:56.802041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.2496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T13:58:56.802064Z","caller":"traceutil/trace.go:171","msg":"trace[1539386902] range","detail":"{range_begin:/registry/services/endpoints/openstack/cinder-api; range_end:; response_count:1; response_revision:12259; }","duration":"228.534398ms","start":"2026-10-14T13:58:56.573514Z","end":"2026-10-14T13:58:56.802048Z","steps":["trace[1539386902] 'agreement among raft nodes before linearized reading' (duration: 228.302702ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:58:56.802061Z","caller":"traceutil/trace.go:171","msg":"trace[1868011112] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:12259; }","duration":"223.043508ms","start":"2026-10-14T13:58:56.578995Z","end":"2026-10-14T13:58:56.802038Z","steps":["trace[1868011112] 'agreement among raft nodes before linearized reading' (duration: 222.825642ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:58:56.801782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.247963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T13:58:56.802101Z","caller":"traceutil/trace.go:171","msg":"trace[1711878992] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:12259; }","duration":"228.321682ms","start":"2026-10-14T13:58:56.573764Z","end":"2026-10-14T13:58:56.802085Z","steps":["trace[1711878992] 'agreement among raft nodes before linearized reading' (duration: 228.24646ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:58:56.802122Z","caller":"traceutil/trace.go:171","msg":"trace[1908488246] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:12259; }","duration":"227.624574ms","start":"2026-10-14T13:58:56.574487Z","end":"2026-10-14T13:58:56.802112Z","steps":["trace[1908488246] 'agreement among raft nodes before linearized reading' (duration: 227.223603ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:58:56.801776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.426491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:1 size:5077"} {"level":"warn","ts":"2026-10-14T13:58:56.802064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.899928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T13:58:56.802199Z","caller":"traceutil/trace.go:171","msg":"trace[1502043389] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:12259; }","duration":"229.055043ms","start":"2026-10-14T13:58:56.573136Z","end":"2026-10-14T13:58:56.802191Z","steps":["trace[1502043389] 'agreement among raft nodes before linearized reading' (duration: 228.901979ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:58:56.80217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.575962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-14T13:58:56.802185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.457346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T13:58:56.802262Z","caller":"traceutil/trace.go:171","msg":"trace[39645224] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:12259; }","duration":"227.717096ms","start":"2026-10-14T13:58:56.574525Z","end":"2026-10-14T13:58:56.802242Z","steps":["trace[39645224] 'agreement among raft nodes before linearized reading' (duration: 227.47049ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:58:56.802306Z","caller":"traceutil/trace.go:171","msg":"trace[196815051] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:12259; }","duration":"228.597609ms","start":"2026-10-14T13:58:56.573687Z","end":"2026-10-14T13:58:56.802284Z","steps":["trace[196815051] 'agreement among raft nodes before linearized reading' (duration: 228.423295ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:58:56.802203Z","caller":"traceutil/trace.go:171","msg":"trace[862797415] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:12259; }","duration":"222.888794ms","start":"2026-10-14T13:58:56.579299Z","end":"2026-10-14T13:58:56.802188Z","steps":["trace[862797415] 'agreement among raft nodes before linearized reading' (duration: 222.325778ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:58:56.866203Z","caller":"traceutil/trace.go:171","msg":"trace[133679205] transaction","detail":"{read_only:false; response_revision:12260; number_of_response:1; }","duration":"102.45848ms","start":"2026-10-14T13:58:56.76371Z","end":"2026-10-14T13:58:56.866169Z","steps":["trace[133679205] 'process raft request' (duration: 101.688399ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:58:57.138244Z","caller":"traceutil/trace.go:171","msg":"trace[1301578871] transaction","detail":"{read_only:false; response_revision:12266; number_of_response:1; }","duration":"135.97915ms","start":"2026-10-14T13:58:57.002241Z","end":"2026-10-14T13:58:57.13822Z","steps":["trace[1301578871] 'process raft request' (duration: 135.717403ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:58:57.138459Z","caller":"traceutil/trace.go:171","msg":"trace[1386224454] linearizableReadLoop","detail":"{readStateIndex:12695; appliedIndex:12693; }","duration":"109.670798ms","start":"2026-10-14T13:58:57.028759Z","end":"2026-10-14T13:58:57.138429Z","steps":["trace[1386224454] 'read index received' (duration: 8.73573ms)","trace[1386224454] 'applied index is now lower than readState.Index' (duration: 100.932688ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:58:57.138602Z","caller":"traceutil/trace.go:171","msg":"trace[1764539191] transaction","detail":"{read_only:false; response_revision:12267; number_of_response:1; }","duration":"109.206376ms","start":"2026-10-14T13:58:57.029385Z","end":"2026-10-14T13:58:57.138591Z","steps":["trace[1764539191] 'process raft request' (duration: 108.777714ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:58:57.138848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.073589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-lvh8p\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-10-14T13:58:57.138907Z","caller":"traceutil/trace.go:171","msg":"trace[36334844] range","detail":"{range_begin:/registry/pods/openstack/keepalived-lvh8p; range_end:; response_count:1; response_revision:12267; }","duration":"110.184392ms","start":"2026-10-14T13:58:57.028713Z","end":"2026-10-14T13:58:57.138898Z","steps":["trace[36334844] 'agreement among raft nodes before linearized reading' (duration: 110.002027ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:58:57.633196Z","caller":"traceutil/trace.go:171","msg":"trace[117792973] transaction","detail":"{read_only:false; response_revision:12268; number_of_response:1; }","duration":"286.838697ms","start":"2026-10-14T13:58:57.346333Z","end":"2026-10-14T13:58:57.633171Z","steps":["trace[117792973] 'process raft request' (duration: 286.688273ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:59:12.277719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.454317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T13:59:12.277799Z","caller":"traceutil/trace.go:171","msg":"trace[1844081514] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12385; }","duration":"119.57352ms","start":"2026-10-14T13:59:12.158208Z","end":"2026-10-14T13:59:12.277781Z","steps":["trace[1844081514] 'agreement among raft nodes before linearized reading' (duration: 119.456597ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:59:42.706337Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10414} {"level":"info","ts":"2026-10-14T13:59:42.857653Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10414,"took":"149.071229ms","hash":877075978,"current-db-size-bytes":56582144,"current-db-size":"57 MB","current-db-size-in-use-bytes":24907776,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-10-14T13:59:42.857714Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":877075978,"revision":10414,"compact-revision":8044} {"level":"info","ts":"2026-10-14T14:04:42.729214Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12582} {"level":"info","ts":"2026-10-14T14:04:42.829668Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12582,"took":"97.714597ms","hash":3828827268,"current-db-size-bytes":56582144,"current-db-size":"57 MB","current-db-size-in-use-bytes":27766784,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-14T14:04:42.829729Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3828827268,"revision":12582,"compact-revision":10414} {"level":"info","ts":"2026-10-14T14:05:24.36869Z","caller":"traceutil/trace.go:171","msg":"trace[1684652417] linearizableReadLoop","detail":"{readStateIndex:15399; appliedIndex:15398; }","duration":"105.642574ms","start":"2026-10-14T14:05:24.263025Z","end":"2026-10-14T14:05:24.368667Z","steps":["trace[1684652417] 'read index received' (duration: 15.116345ms)","trace[1684652417] 'applied index is now lower than readState.Index' (duration: 90.525309ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T14:05:24.368941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.911182ms","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-10-14T14:05:24.368977Z","caller":"traceutil/trace.go:171","msg":"trace[2105763833] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:14879; }","duration":"105.998605ms","start":"2026-10-14T14:05:24.26297Z","end":"2026-10-14T14:05:24.368968Z","steps":["trace[2105763833] 'agreement among raft nodes before linearized reading' (duration: 105.83087ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:05:24.36916Z","caller":"traceutil/trace.go:171","msg":"trace[612485519] transaction","detail":"{read_only:false; response_revision:14879; number_of_response:1; }","duration":"154.519598ms","start":"2026-10-14T14:05:24.214628Z","end":"2026-10-14T14:05:24.369148Z","steps":["trace[612485519] 'process raft request' (duration: 63.595188ms)","trace[612485519] 'compare' (duration: 90.225201ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T14:05:53.615863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.632915ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T14:05:53.615995Z","caller":"traceutil/trace.go:171","msg":"trace[1755277986] transaction","detail":"{read_only:false; response_revision:15032; number_of_response:1; }","duration":"135.214158ms","start":"2026-10-14T14:05:53.480756Z","end":"2026-10-14T14:05:53.61597Z","steps":["trace[1755277986] 'process raft request' (duration: 21.345526ms)","trace[1755277986] 'compare' (duration: 113.397459ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T14:06:03.065065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.135031ms","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-14T14:06:03.065162Z","caller":"traceutil/trace.go:171","msg":"trace[1546642904] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15090; }","duration":"476.237145ms","start":"2026-10-14T14:06:02.588901Z","end":"2026-10-14T14:06:03.065138Z","steps":["trace[1546642904] 'range keys from in-memory index tree' (duration: 475.974767ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:06:03.065211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T14:06:02.588823Z","time spent":"476.376199ms","remote":"127.0.0.1:59156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-10-14T14:06:03.210401Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8961777581666967200,"retry-timeout":"500ms"} {"level":"info","ts":"2026-10-14T14:06:03.245718Z","caller":"traceutil/trace.go:171","msg":"trace[1603713663] transaction","detail":"{read_only:false; response_revision:15091; number_of_response:1; }","duration":"619.024199ms","start":"2026-10-14T14:06:02.626665Z","end":"2026-10-14T14:06:03.24569Z","steps":["trace[1603713663] 'process raft request' (duration: 618.878475ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:06:03.245909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T14:06:02.626642Z","time spent":"619.152153ms","remote":"127.0.0.1:59156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T14:06:03.254739Z","caller":"traceutil/trace.go:171","msg":"trace[1069324161] transaction","detail":"{read_only:false; response_revision:15092; number_of_response:1; }","duration":"625.93865ms","start":"2026-10-14T14:06:02.628752Z","end":"2026-10-14T14:06:03.25469Z","steps":["trace[1069324161] 'process raft request' (duration: 625.737764ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:06:03.25502Z","caller":"traceutil/trace.go:171","msg":"trace[330891842] transaction","detail":"{read_only:false; response_revision:15093; number_of_response:1; }","duration":"185.447008ms","start":"2026-10-14T14:06:03.069546Z","end":"2026-10-14T14:06:03.254993Z","steps":["trace[330891842] 'process raft request' (duration: 185.101789ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:06:03.25502Z","caller":"traceutil/trace.go:171","msg":"trace[1811034434] linearizableReadLoop","detail":"{readStateIndex:15623; appliedIndex:15620; }","duration":"544.590943ms","start":"2026-10-14T14:06:02.71036Z","end":"2026-10-14T14:06:03.254951Z","steps":["trace[1811034434] 'read index received' (duration: 535.276357ms)","trace[1811034434] 'applied index is now lower than readState.Index' (duration: 9.311056ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T14:06:03.25525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.961517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-14T14:06:03.255265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T14:06:02.628738Z","time spent":"626.072173ms","remote":"127.0.0.1:59156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T14:06:03.255304Z","caller":"traceutil/trace.go:171","msg":"trace[1388246641] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:15093; }","duration":"412.022388ms","start":"2026-10-14T14:06:02.843265Z","end":"2026-10-14T14:06:03.255288Z","steps":["trace[1388246641] 'agreement among raft nodes before linearized reading' (duration: 411.929506ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:06:03.255346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T14:06:02.843211Z","time spent":"412.125281ms","remote":"127.0.0.1:45678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"warn","ts":"2026-10-14T14:06:03.255365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.418849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/openstack/ovn-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T14:06:03.255485Z","caller":"traceutil/trace.go:171","msg":"trace[612796994] range","detail":"{range_begin:/registry/daemonsets/openstack/ovn-controller; range_end:; response_count:0; response_revision:15093; }","duration":"244.590304ms","start":"2026-10-14T14:06:03.010863Z","end":"2026-10-14T14:06:03.255453Z","steps":["trace[612796994] 'agreement among raft nodes before linearized reading' (duration: 244.356007ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:06:03.256145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.038595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-lvh8p\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-10-14T14:06:03.256579Z","caller":"traceutil/trace.go:171","msg":"trace[189309700] range","detail":"{range_begin:/registry/pods/openstack/keepalived-lvh8p; range_end:; response_count:1; response_revision:15093; }","duration":"546.073964ms","start":"2026-10-14T14:06:02.710311Z","end":"2026-10-14T14:06:03.256385Z","steps":["trace[189309700] 'agreement among raft nodes before linearized reading' (duration: 544.759487ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:06:03.256654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T14:06:02.710291Z","time spent":"546.342861ms","remote":"127.0.0.1:59068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6543,"request content":"key:\"/registry/pods/openstack/keepalived-lvh8p\" "} {"level":"info","ts":"2026-10-14T14:06:14.145237Z","caller":"traceutil/trace.go:171","msg":"trace[479248502] transaction","detail":"{read_only:false; response_revision:15273; number_of_response:1; }","duration":"166.889319ms","start":"2026-10-14T14:06:13.978262Z","end":"2026-10-14T14:06:14.145152Z","steps":["trace[479248502] 'process raft request' (duration: 166.57159ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:07:46.449807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.054986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-14T14:07:46.449893Z","caller":"traceutil/trace.go:171","msg":"trace[1200692315] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:16320; }","duration":"174.176419ms","start":"2026-10-14T14:07:46.275701Z","end":"2026-10-14T14:07:46.449878Z","steps":["trace[1200692315] 'count revisions from in-memory index tree' (duration: 173.986134ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:07:46.450082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.592816ms","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-14T14:07:46.450137Z","caller":"traceutil/trace.go:171","msg":"trace[1376563642] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:16320; }","duration":"164.683298ms","start":"2026-10-14T14:07:46.285438Z","end":"2026-10-14T14:07:46.450121Z","steps":["trace[1376563642] 'range keys from in-memory index tree' (duration: 164.415401ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:07:46.450563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.614422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-14T14:07:46.45069Z","caller":"traceutil/trace.go:171","msg":"trace[227271613] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:16320; }","duration":"194.813107ms","start":"2026-10-14T14:07:46.255834Z","end":"2026-10-14T14:07:46.450647Z","steps":["trace[227271613] 'count revisions from in-memory index tree' (duration: 194.542609ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:07:46.605649Z","caller":"traceutil/trace.go:171","msg":"trace[1614738881] transaction","detail":"{read_only:false; response_revision:16321; number_of_response:1; }","duration":"151.139166ms","start":"2026-10-14T14:07:46.454486Z","end":"2026-10-14T14:07:46.605625Z","steps":["trace[1614738881] 'process raft request' (duration: 151.002622ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:07:46.74255Z","caller":"traceutil/trace.go:171","msg":"trace[1105077208] linearizableReadLoop","detail":"{readStateIndex:16886; appliedIndex:16885; }","duration":"130.890839ms","start":"2026-10-14T14:07:46.611633Z","end":"2026-10-14T14:07:46.742524Z","steps":["trace[1105077208] 'read index received' (duration: 130.402766ms)","trace[1105077208] 'applied index is now lower than readState.Index' (duration: 486.993µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T14:07:46.742584Z","caller":"traceutil/trace.go:171","msg":"trace[760807407] transaction","detail":"{read_only:false; response_revision:16322; number_of_response:1; }","duration":"196.894944ms","start":"2026-10-14T14:07:46.545661Z","end":"2026-10-14T14:07:46.742556Z","steps":["trace[760807407] 'process raft request' (duration: 196.431661ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:07:46.744015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.356949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:80 size:776683"} {"level":"info","ts":"2026-10-14T14:07:46.744111Z","caller":"traceutil/trace.go:171","msg":"trace[701268556] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:80; response_revision:16322; }","duration":"132.484253ms","start":"2026-10-14T14:07:46.611607Z","end":"2026-10-14T14:07:46.744091Z","steps":["trace[701268556] 'agreement among raft nodes before linearized reading' (duration: 131.016213ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:09:42.741414Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14587} {"level":"info","ts":"2026-10-14T14:09:42.827533Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14587,"took":"81.698836ms","hash":1157598525,"current-db-size-bytes":56582144,"current-db-size":"57 MB","current-db-size-in-use-bytes":31748096,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-14T14:09:42.827661Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1157598525,"revision":14587,"compact-revision":12582} {"level":"info","ts":"2026-10-14T14:13:29.855605Z","caller":"traceutil/trace.go:171","msg":"trace[653017761] transaction","detail":"{read_only:false; response_revision:18826; number_of_response:1; }","duration":"152.485529ms","start":"2026-10-14T14:13:29.703098Z","end":"2026-10-14T14:13:29.855583Z","steps":["trace[653017761] 'process raft request' (duration: 152.379566ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:13:37.164274Z","caller":"traceutil/trace.go:171","msg":"trace[299305967] transaction","detail":"{read_only:false; response_revision:18875; number_of_response:1; }","duration":"108.446069ms","start":"2026-10-14T14:13:37.055755Z","end":"2026-10-14T14:13:37.164201Z","steps":["trace[299305967] 'process raft request' (duration: 108.059469ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:13:37.234069Z","caller":"traceutil/trace.go:171","msg":"trace[760785440] transaction","detail":"{read_only:false; response_revision:18876; number_of_response:1; }","duration":"104.696106ms","start":"2026-10-14T14:13:37.129331Z","end":"2026-10-14T14:13:37.234027Z","steps":["trace[760785440] 'process raft request' (duration: 104.301646ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:13:37.517934Z","caller":"traceutil/trace.go:171","msg":"trace[1672990666] transaction","detail":"{read_only:false; response_revision:18877; number_of_response:1; }","duration":"210.738899ms","start":"2026-10-14T14:13:37.307102Z","end":"2026-10-14T14:13:37.517841Z","steps":["trace[1672990666] 'process raft request' (duration: 203.267574ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:13:38.261938Z","caller":"traceutil/trace.go:171","msg":"trace[129744258] transaction","detail":"{read_only:false; response_revision:18878; number_of_response:1; }","duration":"366.781706ms","start":"2026-10-14T14:13:37.895128Z","end":"2026-10-14T14:13:38.261909Z","steps":["trace[129744258] 'process raft request' (duration: 366.601451ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:13:38.261923Z","caller":"traceutil/trace.go:171","msg":"trace[1113572787] linearizableReadLoop","detail":"{readStateIndex:19527; appliedIndex:19526; }","duration":"366.246591ms","start":"2026-10-14T14:13:37.895651Z","end":"2026-10-14T14:13:38.261898Z","steps":["trace[1113572787] 'read index received' (duration: 366.075757ms)","trace[1113572787] 'applied index is now lower than readState.Index' (duration: 169.844µs)"],"step_count":2} {"level":"warn","ts":"2026-10-14T14:13:38.262107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T14:13:37.89511Z","time spent":"366.92216ms","remote":"127.0.0.1:59156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T14:13:38.262218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.56107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-10-14T14:13:38.262279Z","caller":"traceutil/trace.go:171","msg":"trace[993769608] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18878; }","duration":"366.669352ms","start":"2026-10-14T14:13:37.895594Z","end":"2026-10-14T14:13:38.262264Z","steps":["trace[993769608] 'agreement among raft nodes before linearized reading' (duration: 366.418145ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:13:38.262316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T14:13:37.895583Z","time spent":"366.726074ms","remote":"127.0.0.1:59156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-14T14:13:38.285819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.907124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-14T14:13:38.285864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.512992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/thanosrulers/\" range_end:\"/registry/monitoring.coreos.com/thanosrulers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-14T14:13:38.285947Z","caller":"traceutil/trace.go:171","msg":"trace[462400093] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18879; }","duration":"128.056777ms","start":"2026-10-14T14:13:38.157867Z","end":"2026-10-14T14:13:38.285923Z","steps":["trace[462400093] 'agreement among raft nodes before linearized reading' (duration: 127.897313ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:13:38.286017Z","caller":"traceutil/trace.go:171","msg":"trace[879544691] range","detail":"{range_begin:/registry/monitoring.coreos.com/thanosrulers/; range_end:/registry/monitoring.coreos.com/thanosrulers0; response_count:0; response_revision:18879; }","duration":"155.678256ms","start":"2026-10-14T14:13:38.130273Z","end":"2026-10-14T14:13:38.285951Z","steps":["trace[879544691] 'agreement among raft nodes before linearized reading' (duration: 155.501341ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:13:38.285799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.201068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-14T14:13:38.286076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.621232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-14T14:13:38.286105Z","caller":"traceutil/trace.go:171","msg":"trace[1484896398] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:18879; }","duration":"355.562907ms","start":"2026-10-14T14:13:37.930508Z","end":"2026-10-14T14:13:38.286071Z","steps":["trace[1484896398] 'agreement among raft nodes before linearized reading' (duration: 355.183367ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:13:38.286079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.292502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-10-14T14:13:38.286142Z","caller":"traceutil/trace.go:171","msg":"trace[480917824] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:18879; }","duration":"338.720605ms","start":"2026-10-14T14:13:37.9474Z","end":"2026-10-14T14:13:38.286121Z","steps":["trace[480917824] 'agreement among raft nodes before linearized reading' (duration: 338.498769ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:13:38.286167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T14:13:37.930484Z","time spent":"355.66214ms","remote":"127.0.0.1:59124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":29,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"info","ts":"2026-10-14T14:13:38.286195Z","caller":"traceutil/trace.go:171","msg":"trace[646192768] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18879; }","duration":"295.489417ms","start":"2026-10-14T14:13:37.990681Z","end":"2026-10-14T14:13:38.28617Z","steps":["trace[646192768] 'agreement among raft nodes before linearized reading' (duration: 295.146128ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:13:38.286302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T14:13:37.947376Z","time spent":"338.91098ms","remote":"127.0.0.1:59156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-14T14:13:38.286562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.22875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-5vs4x\" ","response":"range_response_count:1 size:22090"} {"level":"info","ts":"2026-10-14T14:13:38.286616Z","caller":"traceutil/trace.go:171","msg":"trace[792348027] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-5vs4x; range_end:; response_count:1; response_revision:18879; }","duration":"180.310513ms","start":"2026-10-14T14:13:38.106289Z","end":"2026-10-14T14:13:38.286599Z","steps":["trace[792348027] 'agreement among raft nodes before linearized reading' (duration: 179.367167ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:13:38.492014Z","caller":"traceutil/trace.go:171","msg":"trace[571951632] linearizableReadLoop","detail":"{readStateIndex:19529; appliedIndex:19528; }","duration":"206.477112ms","start":"2026-10-14T14:13:38.285506Z","end":"2026-10-14T14:13:38.491983Z","steps":["trace[571951632] 'read index received' (duration: 116.186992ms)","trace[571951632] 'applied index is now lower than readState.Index' (duration: 90.28833ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T14:13:38.492096Z","caller":"traceutil/trace.go:171","msg":"trace[960861457] transaction","detail":"{read_only:false; response_revision:18880; number_of_response:1; }","duration":"225.895785ms","start":"2026-10-14T14:13:38.266174Z","end":"2026-10-14T14:13:38.49207Z","steps":["trace[960861457] 'process raft request' (duration: 135.504062ms)","trace[960861457] 'compare' (duration: 90.116386ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T14:13:38.492283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.07322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"info","ts":"2026-10-14T14:13:38.492351Z","caller":"traceutil/trace.go:171","msg":"trace[1235775695] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:18880; }","duration":"218.180814ms","start":"2026-10-14T14:13:38.274153Z","end":"2026-10-14T14:13:38.492333Z","steps":["trace[1235775695] 'agreement among raft nodes before linearized reading' (duration: 217.929907ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:13:38.719847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.776213ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-14T14:13:38.720065Z","caller":"traceutil/trace.go:171","msg":"trace[1395341252] linearizableReadLoop","detail":"{readStateIndex:19532; appliedIndex:19529; }","duration":"227.957672ms","start":"2026-10-14T14:13:38.492094Z","end":"2026-10-14T14:13:38.720051Z","steps":["trace[1395341252] 'read index received' (duration: 120.909791ms)","trace[1395341252] 'applied index is now lower than readState.Index' (duration: 107.046981ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T14:13:38.720438Z","caller":"traceutil/trace.go:171","msg":"trace[584140978] transaction","detail":"{read_only:false; response_revision:18882; number_of_response:1; }","duration":"429.044926ms","start":"2026-10-14T14:13:38.291383Z","end":"2026-10-14T14:13:38.720428Z","steps":["trace[584140978] 'process raft request' (duration: 428.555743ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:13:38.720416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.924765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-10-14T14:13:38.720431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.68435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"warn","ts":"2026-10-14T14:13:38.720441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.506809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-14T14:13:38.720491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T14:13:38.291357Z","time spent":"429.107177ms","remote":"127.0.0.1:59156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T14:13:38.720501Z","caller":"traceutil/trace.go:171","msg":"trace[471244990] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/; range_end:/registry/ceph.rook.io/cephclusters0; response_count:0; response_revision:18884; }","duration":"183.055429ms","start":"2026-10-14T14:13:38.537422Z","end":"2026-10-14T14:13:38.720477Z","steps":["trace[471244990] 'agreement among raft nodes before linearized reading' (duration: 182.902364ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:13:38.720461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.828794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-vkrbj\" ","response":"range_response_count:1 size:9791"} {"level":"info","ts":"2026-10-14T14:13:38.720533Z","caller":"traceutil/trace.go:171","msg":"trace[105712371] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18884; }","duration":"433.668512ms","start":"2026-10-14T14:13:38.286841Z","end":"2026-10-14T14:13:38.720509Z","steps":["trace[105712371] 'agreement among raft nodes before linearized reading' (duration: 433.477877ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:13:38.720543Z","caller":"traceutil/trace.go:171","msg":"trace[1344134090] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18884; }","duration":"209.815854ms","start":"2026-10-14T14:13:38.510674Z","end":"2026-10-14T14:13:38.720489Z","steps":["trace[1344134090] 'agreement among raft nodes before linearized reading' (duration: 209.592888ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:13:38.720578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T14:13:38.286825Z","time spent":"433.745775ms","remote":"127.0.0.1:58918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-14T14:13:38.720575Z","caller":"traceutil/trace.go:171","msg":"trace[523573558] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-vkrbj; range_end:; response_count:1; response_revision:18884; }","duration":"300.988188ms","start":"2026-10-14T14:13:38.419566Z","end":"2026-10-14T14:13:38.720554Z","steps":["trace[523573558] 'agreement among raft nodes before linearized reading' (duration: 300.71609ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:13:38.720625Z","caller":"traceutil/trace.go:171","msg":"trace[534081331] transaction","detail":"{read_only:false; response_revision:18881; number_of_response:1; }","duration":"429.56063ms","start":"2026-10-14T14:13:38.291053Z","end":"2026-10-14T14:13:38.720614Z","steps":["trace[534081331] 'process raft request' (duration: 321.937314ms)","trace[534081331] 'compare' (duration: 106.505066ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T14:13:38.720668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T14:13:38.291029Z","time spent":"429.619302ms","remote":"127.0.0.1:59156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T14:13:38.720653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T14:13:38.419554Z","time spent":"301.087791ms","remote":"127.0.0.1:59068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":9814,"request content":"key:\"/registry/pods/openstack/nova-cell-setup-vkrbj\" "} {"level":"info","ts":"2026-10-14T14:13:38.72075Z","caller":"traceutil/trace.go:171","msg":"trace[1915533573] transaction","detail":"{read_only:false; response_revision:18883; number_of_response:1; }","duration":"316.003221ms","start":"2026-10-14T14:13:38.404737Z","end":"2026-10-14T14:13:38.72074Z","steps":["trace[1915533573] 'process raft request' (duration: 315.2465ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:13:38.720791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T14:13:38.404712Z","time spent":"316.058163ms","remote":"127.0.0.1:59156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T14:13:38.720832Z","caller":"traceutil/trace.go:171","msg":"trace[2051698439] transaction","detail":"{read_only:false; response_revision:18884; number_of_response:1; }","duration":"192.396365ms","start":"2026-10-14T14:13:38.528417Z","end":"2026-10-14T14:13:38.720813Z","steps":["trace[2051698439] 'process raft request' (duration: 191.597733ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:13:38.721714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.11347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:96 size:947728"} {"level":"info","ts":"2026-10-14T14:13:38.721769Z","caller":"traceutil/trace.go:171","msg":"trace[1533081657] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:96; response_revision:18884; }","duration":"428.194913ms","start":"2026-10-14T14:13:38.293563Z","end":"2026-10-14T14:13:38.721758Z","steps":["trace[1533081657] 'agreement among raft nodes before linearized reading' (duration: 426.841746ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:13:38.721805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T14:13:38.29355Z","time spent":"428.242794ms","remote":"127.0.0.1:59068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":96,"response size":947751,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"info","ts":"2026-10-14T14:14:19.781498Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b3aa5b67741e7c5e","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-14T14:14:19.798293Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-14T14:14:19.798483Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-10-14T14:14:42.749424Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17044} {"level":"info","ts":"2026-10-14T14:14:42.85353Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17044,"took":"100.83826ms","hash":463728614,"current-db-size-bytes":56582144,"current-db-size":"57 MB","current-db-size-in-use-bytes":34344960,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-10-14T14:14:42.853609Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":463728614,"revision":17044,"compact-revision":14587} {"level":"info","ts":"2026-10-14T14:19:42.756179Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19658} {"level":"info","ts":"2026-10-14T14:19:42.870975Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19658,"took":"111.232504ms","hash":536759269,"current-db-size-bytes":56582144,"current-db-size":"57 MB","current-db-size-in-use-bytes":30216192,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-14T14:19:42.871041Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":536759269,"revision":19658,"compact-revision":17044} {"level":"warn","ts":"2026-10-14T14:19:52.418994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.582482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-10-14T14:19:52.419091Z","caller":"traceutil/trace.go:171","msg":"trace[888253649] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:21732; }","duration":"159.733747ms","start":"2026-10-14T14:19:52.259336Z","end":"2026-10-14T14:19:52.419069Z","steps":["trace[888253649] 'range keys from in-memory index tree' (duration: 159.344046ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:19:52.419319Z","caller":"traceutil/trace.go:171","msg":"trace[1798954996] transaction","detail":"{read_only:false; response_revision:21733; number_of_response:1; }","duration":"146.298498ms","start":"2026-10-14T14:19:52.272919Z","end":"2026-10-14T14:19:52.419217Z","steps":["trace[1798954996] 'process raft request' (duration: 86.715971ms)","trace[1798954996] 'compare' (duration: 59.246867ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T14:19:52.812788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.818553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-14T14:19:52.812905Z","caller":"traceutil/trace.go:171","msg":"trace[564301618] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:21735; }","duration":"256.979667ms","start":"2026-10-14T14:19:52.555902Z","end":"2026-10-14T14:19:52.812881Z","steps":["trace[564301618] 'range keys from in-memory index tree' (duration: 256.679998ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:19:52.90754Z","caller":"traceutil/trace.go:171","msg":"trace[995521756] transaction","detail":"{read_only:false; response_revision:21736; number_of_response:1; }","duration":"268.083141ms","start":"2026-10-14T14:19:52.63941Z","end":"2026-10-14T14:19:52.907494Z","steps":["trace[995521756] 'process raft request' (duration: 267.801104ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:19:53.894342Z","caller":"traceutil/trace.go:171","msg":"trace[220720397] transaction","detail":"{read_only:false; response_revision:21740; number_of_response:1; }","duration":"106.045922ms","start":"2026-10-14T14:19:53.788264Z","end":"2026-10-14T14:19:53.89431Z","steps":["trace[220720397] 'process raft request' (duration: 105.794316ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:19:54.127528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.107254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-14T14:19:54.127599Z","caller":"traceutil/trace.go:171","msg":"trace[1987613225] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:21740; }","duration":"177.230467ms","start":"2026-10-14T14:19:53.950353Z","end":"2026-10-14T14:19:54.127583Z","steps":["trace[1987613225] 'count revisions from in-memory index tree' (duration: 177.029812ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:24:00.258803Z","caller":"traceutil/trace.go:171","msg":"trace[1396292899] transaction","detail":"{read_only:false; response_revision:23799; number_of_response:1; }","duration":"116.009026ms","start":"2026-10-14T14:24:00.142761Z","end":"2026-10-14T14:24:00.25877Z","steps":["trace[1396292899] 'process raft request' (duration: 115.780949ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:24:00.258802Z","caller":"traceutil/trace.go:171","msg":"trace[1057107429] transaction","detail":"{read_only:false; response_revision:23798; number_of_response:1; }","duration":"116.346315ms","start":"2026-10-14T14:24:00.142388Z","end":"2026-10-14T14:24:00.258734Z","steps":["trace[1057107429] 'process raft request' (duration: 116.016535ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:24:00.258901Z","caller":"traceutil/trace.go:171","msg":"trace[161337837] transaction","detail":"{read_only:false; response_revision:23800; number_of_response:1; }","duration":"113.636051ms","start":"2026-10-14T14:24:00.145216Z","end":"2026-10-14T14:24:00.258852Z","steps":["trace[161337837] 'process raft request' (duration: 113.412965ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:24:00.259066Z","caller":"traceutil/trace.go:171","msg":"trace[1433940034] transaction","detail":"{read_only:false; response_revision:23801; number_of_response:1; }","duration":"111.379799ms","start":"2026-10-14T14:24:00.147648Z","end":"2026-10-14T14:24:00.259028Z","steps":["trace[1433940034] 'process raft request' (duration: 111.07492ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:24:00.259908Z","caller":"traceutil/trace.go:171","msg":"trace[676904198] linearizableReadLoop","detail":"{readStateIndex:24609; appliedIndex:24606; }","duration":"115.372588ms","start":"2026-10-14T14:24:00.144509Z","end":"2026-10-14T14:24:00.259881Z","steps":["trace[676904198] 'read index received' (duration: 63.039401ms)","trace[676904198] 'applied index is now lower than readState.Index' (duration: 52.332167ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T14:24:00.260328Z","caller":"traceutil/trace.go:171","msg":"trace[228412296] transaction","detail":"{read_only:false; response_revision:23802; number_of_response:1; }","duration":"100.773137ms","start":"2026-10-14T14:24:00.159521Z","end":"2026-10-14T14:24:00.260294Z","steps":["trace[228412296] 'process raft request' (duration: 99.963725ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:24:00.261006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.591237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/clusterresourcesets.addons.cluster.x-k8s.io\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-14T14:24:00.261066Z","caller":"traceutil/trace.go:171","msg":"trace[347455992] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/clusterresourcesets.addons.cluster.x-k8s.io; range_end:; response_count:0; response_revision:23802; }","duration":"106.68479ms","start":"2026-10-14T14:24:00.154361Z","end":"2026-10-14T14:24:00.261045Z","steps":["trace[347455992] 'agreement among raft nodes before linearized reading' (duration: 106.602608ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:24:00.261183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.252436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-14T14:24:00.260515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.975304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:3959"} {"level":"info","ts":"2026-10-14T14:24:00.261206Z","caller":"traceutil/trace.go:171","msg":"trace[563825010] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:23802; }","duration":"103.304727ms","start":"2026-10-14T14:24:00.157895Z","end":"2026-10-14T14:24:00.2612Z","steps":["trace[563825010] 'agreement among raft nodes before linearized reading' (duration: 103.257936ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:24:00.261287Z","caller":"traceutil/trace.go:171","msg":"trace[891255276] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:23802; }","duration":"116.778227ms","start":"2026-10-14T14:24:00.144475Z","end":"2026-10-14T14:24:00.261254Z","steps":["trace[891255276] 'agreement among raft nodes before linearized reading' (duration: 115.820951ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:24:00.515928Z","caller":"traceutil/trace.go:171","msg":"trace[1842062956] transaction","detail":"{read_only:false; response_revision:23813; number_of_response:1; }","duration":"133.896327ms","start":"2026-10-14T14:24:00.382001Z","end":"2026-10-14T14:24:00.515897Z","steps":["trace[1842062956] 'process raft request' (duration: 118.398411ms)","trace[1842062956] 'compare' (duration: 15.168647ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T14:24:00.516087Z","caller":"traceutil/trace.go:171","msg":"trace[195062179] linearizableReadLoop","detail":"{readStateIndex:24625; appliedIndex:24622; }","duration":"111.001538ms","start":"2026-10-14T14:24:00.405055Z","end":"2026-10-14T14:24:00.516056Z","steps":["trace[195062179] 'read index received' (duration: 95.287087ms)","trace[195062179] 'applied index is now lower than readState.Index' (duration: 15.713231ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T14:24:00.516147Z","caller":"traceutil/trace.go:171","msg":"trace[658702398] transaction","detail":"{read_only:false; response_revision:23814; number_of_response:1; }","duration":"133.068234ms","start":"2026-10-14T14:24:00.383029Z","end":"2026-10-14T14:24:00.516097Z","steps":["trace[658702398] 'process raft request' (duration: 132.752216ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:24:00.516469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.626733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-14T14:24:00.516576Z","caller":"traceutil/trace.go:171","msg":"trace[810928398] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:23815; }","duration":"112.802948ms","start":"2026-10-14T14:24:00.403745Z","end":"2026-10-14T14:24:00.516548Z","steps":["trace[810928398] 'agreement among raft nodes before linearized reading' (duration: 112.50477ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:24:00.516777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.015062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:651"} {"level":"info","ts":"2026-10-14T14:24:00.51689Z","caller":"traceutil/trace.go:171","msg":"trace[1736639350] transaction","detail":"{read_only:false; response_revision:23815; number_of_response:1; }","duration":"118.869955ms","start":"2026-10-14T14:24:00.398005Z","end":"2026-10-14T14:24:00.516875Z","steps":["trace[1736639350] 'process raft request' (duration: 117.903868ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:24:00.516844Z","caller":"traceutil/trace.go:171","msg":"trace[173730631] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:23815; }","duration":"106.126484ms","start":"2026-10-14T14:24:00.4107Z","end":"2026-10-14T14:24:00.516826Z","steps":["trace[173730631] 'agreement among raft nodes before linearized reading' (duration: 105.778815ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:24:00.679753Z","caller":"traceutil/trace.go:171","msg":"trace[1632740154] transaction","detail":"{read_only:false; response_revision:23817; number_of_response:1; }","duration":"156.713833ms","start":"2026-10-14T14:24:00.523002Z","end":"2026-10-14T14:24:00.679715Z","steps":["trace[1632740154] 'process raft request' (duration: 111.056438ms)","trace[1632740154] 'compare' (duration: 45.299945ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T14:24:00.67981Z","caller":"traceutil/trace.go:171","msg":"trace[1801775161] transaction","detail":"{read_only:false; response_revision:23819; number_of_response:1; }","duration":"155.195051ms","start":"2026-10-14T14:24:00.524594Z","end":"2026-10-14T14:24:00.679789Z","steps":["trace[1801775161] 'process raft request' (duration: 155.094028ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:24:00.679803Z","caller":"traceutil/trace.go:171","msg":"trace[1017836391] transaction","detail":"{read_only:false; response_revision:23818; number_of_response:1; }","duration":"155.177171ms","start":"2026-10-14T14:24:00.52459Z","end":"2026-10-14T14:24:00.679767Z","steps":["trace[1017836391] 'process raft request' (duration: 154.977766ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:24:00.680211Z","caller":"traceutil/trace.go:171","msg":"trace[138051643] transaction","detail":"{read_only:false; response_revision:23821; number_of_response:1; }","duration":"143.546372ms","start":"2026-10-14T14:24:00.53664Z","end":"2026-10-14T14:24:00.680187Z","steps":["trace[138051643] 'process raft request' (duration: 143.359967ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:24:00.680145Z","caller":"traceutil/trace.go:171","msg":"trace[972068933] linearizableReadLoop","detail":"{readStateIndex:24629; appliedIndex:24625; }","duration":"154.245115ms","start":"2026-10-14T14:24:00.525875Z","end":"2026-10-14T14:24:00.68012Z","steps":["trace[972068933] 'read index received' (duration: 16.495633ms)","trace[972068933] 'applied index is now lower than readState.Index' (duration: 137.748392ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T14:24:00.68025Z","caller":"traceutil/trace.go:171","msg":"trace[1484890652] transaction","detail":"{read_only:false; response_revision:23820; number_of_response:1; }","duration":"150.621535ms","start":"2026-10-14T14:24:00.529584Z","end":"2026-10-14T14:24:00.680205Z","steps":["trace[1484890652] 'process raft request' (duration: 150.146572ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:24:00.680364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.45408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:709"} {"level":"info","ts":"2026-10-14T14:24:00.680423Z","caller":"traceutil/trace.go:171","msg":"trace[1648467270] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:23821; }","duration":"154.568924ms","start":"2026-10-14T14:24:00.525842Z","end":"2026-10-14T14:24:00.68041Z","steps":["trace[1648467270] 'agreement among raft nodes before linearized reading' (duration: 154.352058ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:24:00.683782Z","caller":"traceutil/trace.go:171","msg":"trace[1305786377] transaction","detail":"{read_only:false; response_revision:23822; number_of_response:1; }","duration":"119.739748ms","start":"2026-10-14T14:24:00.564018Z","end":"2026-10-14T14:24:00.683758Z","steps":["trace[1305786377] 'process raft request' (duration: 119.261294ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:24:00.683787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.661579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/extensionconfigs.runtime.cluster.x-k8s.io\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-14T14:24:00.683868Z","caller":"traceutil/trace.go:171","msg":"trace[1856272460] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/extensionconfigs.runtime.cluster.x-k8s.io; range_end:; response_count:0; response_revision:23822; }","duration":"129.787963ms","start":"2026-10-14T14:24:00.554058Z","end":"2026-10-14T14:24:00.683846Z","steps":["trace[1856272460] 'agreement among raft nodes before linearized reading' (duration: 129.635489ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:24:00.683971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.938803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1818"} {"level":"info","ts":"2026-10-14T14:24:00.684044Z","caller":"traceutil/trace.go:171","msg":"trace[287135412] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:23822; }","duration":"124.062026ms","start":"2026-10-14T14:24:00.559962Z","end":"2026-10-14T14:24:00.684024Z","steps":["trace[287135412] 'agreement among raft nodes before linearized reading' (duration: 123.827909ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:24:00.874141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ipaddressclaims.ipam.cluster.x-k8s.io\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-14T14:24:00.874208Z","caller":"traceutil/trace.go:171","msg":"trace[1356168968] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ipaddressclaims.ipam.cluster.x-k8s.io; range_end:; response_count:0; response_revision:23830; }","duration":"105.708743ms","start":"2026-10-14T14:24:00.768484Z","end":"2026-10-14T14:24:00.874192Z","steps":["trace[1356168968] 'agreement among raft nodes before linearized reading' (duration: 105.59336ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:24:01.259138Z","caller":"traceutil/trace.go:171","msg":"trace[1169491687] linearizableReadLoop","detail":"{readStateIndex:24656; appliedIndex:24655; }","duration":"106.898426ms","start":"2026-10-14T14:24:01.152218Z","end":"2026-10-14T14:24:01.259117Z","steps":["trace[1169491687] 'read index received' (duration: 87.184935ms)","trace[1169491687] 'applied index is now lower than readState.Index' (duration: 19.712461ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T14:24:01.259246Z","caller":"traceutil/trace.go:171","msg":"trace[295760838] transaction","detail":"{read_only:false; response_revision:23844; number_of_response:1; }","duration":"109.708903ms","start":"2026-10-14T14:24:01.149494Z","end":"2026-10-14T14:24:01.259202Z","steps":["trace[295760838] 'process raft request' (duration: 89.899709ms)","trace[295760838] 'compare' (duration: 19.623389ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T14:24:01.259292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.05001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-14T14:24:01.259335Z","caller":"traceutil/trace.go:171","msg":"trace[54764949] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1; range_end:; response_count:0; response_revision:23844; }","duration":"107.118571ms","start":"2026-10-14T14:24:01.1522Z","end":"2026-10-14T14:24:01.259319Z","steps":["trace[54764949] 'agreement among raft nodes before linearized reading' (duration: 107.038959ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:24:01.280586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.954132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-14T14:24:01.280646Z","caller":"traceutil/trace.go:171","msg":"trace[1273943833] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:23845; }","duration":"121.052865ms","start":"2026-10-14T14:24:01.159581Z","end":"2026-10-14T14:24:01.280634Z","steps":["trace[1273943833] 'agreement among raft nodes before linearized reading' (duration: 120.923881ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:24:01.280644Z","caller":"traceutil/trace.go:171","msg":"trace[1024014552] transaction","detail":"{read_only:false; response_revision:23845; number_of_response:1; }","duration":"125.26885ms","start":"2026-10-14T14:24:01.155349Z","end":"2026-10-14T14:24:01.280618Z","steps":["trace[1024014552] 'process raft request' (duration: 124.934341ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:24:01.280822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.454948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1125"} {"level":"info","ts":"2026-10-14T14:24:01.280885Z","caller":"traceutil/trace.go:171","msg":"trace[1752078299] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:23845; }","duration":"124.5316ms","start":"2026-10-14T14:24:01.156341Z","end":"2026-10-14T14:24:01.280872Z","steps":["trace[1752078299] 'agreement among raft nodes before linearized reading' (duration: 124.347715ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:24:01.280928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.192941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:16 size:111930"} {"level":"info","ts":"2026-10-14T14:24:01.280979Z","caller":"traceutil/trace.go:171","msg":"trace[647063917] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:16; response_revision:23845; }","duration":"124.323804ms","start":"2026-10-14T14:24:01.156644Z","end":"2026-10-14T14:24:01.280967Z","steps":["trace[647063917] 'agreement among raft nodes before linearized reading' (duration: 124.041206ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:24:01.281076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.082637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/machinedeployments.cluster.x-k8s.io\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-14T14:24:01.281137Z","caller":"traceutil/trace.go:171","msg":"trace[323817420] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/machinedeployments.cluster.x-k8s.io; range_end:; response_count:0; response_revision:23845; }","duration":"120.221981ms","start":"2026-10-14T14:24:01.160899Z","end":"2026-10-14T14:24:01.281121Z","steps":["trace[323817420] 'agreement among raft nodes before linearized reading' (duration: 120.130689ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:24:01.602766Z","caller":"traceutil/trace.go:171","msg":"trace[1071363450] transaction","detail":"{read_only:false; response_revision:23854; number_of_response:1; }","duration":"102.406563ms","start":"2026-10-14T14:24:01.500334Z","end":"2026-10-14T14:24:01.602741Z","steps":["trace[1071363450] 'process raft request' (duration: 102.103964ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:24:01.677323Z","caller":"traceutil/trace.go:171","msg":"trace[1804540379] transaction","detail":"{read_only:false; response_revision:23856; number_of_response:1; }","duration":"158.138283ms","start":"2026-10-14T14:24:01.519155Z","end":"2026-10-14T14:24:01.677294Z","steps":["trace[1804540379] 'process raft request' (duration: 130.564256ms)","trace[1804540379] 'compare' (duration: 27.388842ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T14:24:01.697876Z","caller":"traceutil/trace.go:171","msg":"trace[1484415133] linearizableReadLoop","detail":"{readStateIndex:24668; appliedIndex:24665; }","duration":"169.872835ms","start":"2026-10-14T14:24:01.527981Z","end":"2026-10-14T14:24:01.697853Z","steps":["trace[1484415133] 'read index received' (duration: 74.477616ms)","trace[1484415133] 'applied index is now lower than readState.Index' (duration: 95.393769ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T14:24:01.697892Z","caller":"traceutil/trace.go:171","msg":"trace[1151307811] transaction","detail":"{read_only:false; response_revision:23857; number_of_response:1; }","duration":"157.057533ms","start":"2026-10-14T14:24:01.540777Z","end":"2026-10-14T14:24:01.697834Z","steps":["trace[1151307811] 'process raft request' (duration: 156.474957ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:24:01.69809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.770684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/machinehealthchecks.cluster.x-k8s.io\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-14T14:24:01.698137Z","caller":"traceutil/trace.go:171","msg":"trace[1889571669] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/machinehealthchecks.cluster.x-k8s.io; range_end:; response_count:0; response_revision:23859; }","duration":"188.869897ms","start":"2026-10-14T14:24:01.509256Z","end":"2026-10-14T14:24:01.698126Z","steps":["trace[1889571669] 'agreement among raft nodes before linearized reading' (duration: 188.782374ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:24:01.698223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.713678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1125"} {"level":"info","ts":"2026-10-14T14:24:01.698269Z","caller":"traceutil/trace.go:171","msg":"trace[2051774497] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:23859; }","duration":"162.7826ms","start":"2026-10-14T14:24:01.535475Z","end":"2026-10-14T14:24:01.698258Z","steps":["trace[2051774497] 'agreement among raft nodes before linearized reading' (duration: 162.643016ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:24:01.697887Z","caller":"traceutil/trace.go:171","msg":"trace[1205711899] transaction","detail":"{read_only:false; response_revision:23858; number_of_response:1; }","duration":"116.953711ms","start":"2026-10-14T14:24:01.58091Z","end":"2026-10-14T14:24:01.697864Z","steps":["trace[1205711899] 'process raft request' (duration: 116.570991ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:24:01.698789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.157351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:16 size:111930"} {"level":"info","ts":"2026-10-14T14:24:01.69883Z","caller":"traceutil/trace.go:171","msg":"trace[1357000100] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:16; response_revision:23859; }","duration":"163.215572ms","start":"2026-10-14T14:24:01.535605Z","end":"2026-10-14T14:24:01.698821Z","steps":["trace[1357000100] 'agreement among raft nodes before linearized reading' (duration: 162.978115ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:24:03.157626Z","caller":"traceutil/trace.go:171","msg":"trace[1359407494] transaction","detail":"{read_only:false; response_revision:23960; number_of_response:1; }","duration":"125.548248ms","start":"2026-10-14T14:24:03.032026Z","end":"2026-10-14T14:24:03.157574Z","steps":["trace[1359407494] 'process raft request' (duration: 125.214709ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:24:03.15775Z","caller":"traceutil/trace.go:171","msg":"trace[1144187860] transaction","detail":"{read_only:false; response_revision:23961; number_of_response:1; }","duration":"125.581449ms","start":"2026-10-14T14:24:03.032133Z","end":"2026-10-14T14:24:03.157715Z","steps":["trace[1144187860] 'process raft request' (duration: 125.25812ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:24:03.158341Z","caller":"traceutil/trace.go:171","msg":"trace[1358811785] transaction","detail":"{read_only:false; response_revision:23962; number_of_response:1; }","duration":"121.289671ms","start":"2026-10-14T14:24:03.037006Z","end":"2026-10-14T14:24:03.158296Z","steps":["trace[1358811785] 'process raft request' (duration: 120.561441ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:24:03.158348Z","caller":"traceutil/trace.go:171","msg":"trace[1530221866] linearizableReadLoop","detail":"{readStateIndex:24776; appliedIndex:24773; }","duration":"125.081024ms","start":"2026-10-14T14:24:03.033239Z","end":"2026-10-14T14:24:03.15832Z","steps":["trace[1530221866] 'read index received' (duration: 57.059956ms)","trace[1530221866] 'applied index is now lower than readState.Index' (duration: 68.019818ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T14:24:03.158405Z","caller":"traceutil/trace.go:171","msg":"trace[2022161951] transaction","detail":"{read_only:false; response_revision:23963; number_of_response:1; }","duration":"111.619815ms","start":"2026-10-14T14:24:03.046775Z","end":"2026-10-14T14:24:03.158394Z","steps":["trace[2022161951] 'process raft request' (duration: 110.949737ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:24:03.159161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.887527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:3959"} {"level":"info","ts":"2026-10-14T14:24:03.159435Z","caller":"traceutil/trace.go:171","msg":"trace[1147998655] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:23963; }","duration":"126.186605ms","start":"2026-10-14T14:24:03.033224Z","end":"2026-10-14T14:24:03.15941Z","steps":["trace[1147998655] 'agreement among raft nodes before linearized reading' (duration: 125.182168ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:24:03.190835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.473882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4726"} {"level":"info","ts":"2026-10-14T14:24:03.190934Z","caller":"traceutil/trace.go:171","msg":"trace[379869605] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:23964; }","duration":"146.604085ms","start":"2026-10-14T14:24:03.044308Z","end":"2026-10-14T14:24:03.190912Z","steps":["trace[379869605] 'agreement among raft nodes before linearized reading' (duration: 146.345128ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:24:03.191332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.794369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1818"} {"level":"info","ts":"2026-10-14T14:24:03.191435Z","caller":"traceutil/trace.go:171","msg":"trace[777058548] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:23964; }","duration":"139.922492ms","start":"2026-10-14T14:24:03.051485Z","end":"2026-10-14T14:24:03.191408Z","steps":["trace[777058548] 'agreement among raft nodes before linearized reading' (duration: 139.710936ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:24:03.431099Z","caller":"traceutil/trace.go:171","msg":"trace[112850742] linearizableReadLoop","detail":"{readStateIndex:24787; appliedIndex:24785; }","duration":"125.916788ms","start":"2026-10-14T14:24:03.305156Z","end":"2026-10-14T14:24:03.431073Z","steps":["trace[112850742] 'read index received' (duration: 48.634016ms)","trace[112850742] 'applied index is now lower than readState.Index' (duration: 77.281752ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T14:24:03.431184Z","caller":"traceutil/trace.go:171","msg":"trace[2112575451] transaction","detail":"{read_only:false; response_revision:23971; number_of_response:1; }","duration":"126.436633ms","start":"2026-10-14T14:24:03.304699Z","end":"2026-10-14T14:24:03.431136Z","steps":["trace[2112575451] 'process raft request' (duration: 102.809824ms)","trace[2112575451] 'compare' (duration: 23.334031ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T14:24:03.431285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.683727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/capi-kubeadm-bootstrap-system/capi-kubeadm-bootstrap-controller-manager\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-14T14:24:03.431358Z","caller":"traceutil/trace.go:171","msg":"trace[1618222047] range","detail":"{range_begin:/registry/deployments/capi-kubeadm-bootstrap-system/capi-kubeadm-bootstrap-controller-manager; range_end:; response_count:0; response_revision:23971; }","duration":"127.797129ms","start":"2026-10-14T14:24:03.303544Z","end":"2026-10-14T14:24:03.431341Z","steps":["trace[1618222047] 'agreement among raft nodes before linearized reading' (duration: 127.644585ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:24:03.431427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.350369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:697"} {"level":"info","ts":"2026-10-14T14:24:03.431471Z","caller":"traceutil/trace.go:171","msg":"trace[75995074] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:23971; }","duration":"138.434751ms","start":"2026-10-14T14:24:03.293023Z","end":"2026-10-14T14:24:03.431458Z","steps":["trace[75995074] 'agreement among raft nodes before linearized reading' (duration: 138.171554ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:24:03.469092Z","caller":"traceutil/trace.go:171","msg":"trace[281872212] transaction","detail":"{read_only:false; response_revision:23972; number_of_response:1; }","duration":"101.414855ms","start":"2026-10-14T14:24:03.367642Z","end":"2026-10-14T14:24:03.469057Z","steps":["trace[281872212] 'process raft request' (duration: 101.279991ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:24:03.469242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.926722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1125"} {"level":"info","ts":"2026-10-14T14:24:03.469318Z","caller":"traceutil/trace.go:171","msg":"trace[967464864] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:23972; }","duration":"160.032574ms","start":"2026-10-14T14:24:03.309269Z","end":"2026-10-14T14:24:03.469302Z","steps":["trace[967464864] 'agreement among raft nodes before linearized reading' (duration: 159.806258ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:24:03.469472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.748757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:16 size:111930"} {"level":"info","ts":"2026-10-14T14:24:03.469745Z","caller":"traceutil/trace.go:171","msg":"trace[1558290469] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:16; response_revision:23972; }","duration":"160.048155ms","start":"2026-10-14T14:24:03.309678Z","end":"2026-10-14T14:24:03.469727Z","steps":["trace[1558290469] 'agreement among raft nodes before linearized reading' (duration: 159.386247ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:24:03.751126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.981605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/capi-kubeadm-bootstrap-validating-webhook-configuration\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-14T14:24:03.751183Z","caller":"traceutil/trace.go:171","msg":"trace[256525885] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/capi-kubeadm-bootstrap-validating-webhook-configuration; range_end:; response_count:0; response_revision:23986; }","duration":"104.065888ms","start":"2026-10-14T14:24:03.647103Z","end":"2026-10-14T14:24:03.751169Z","steps":["trace[256525885] 'agreement among raft nodes before linearized reading' (duration: 103.986196ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:24:03.751314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.483061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/capi-kubeadm-bootstrap-system/capi-kubeadm-bootstrap-controller-manager\" ","response":"range_response_count:1 size:4635"} {"level":"info","ts":"2026-10-14T14:24:03.751336Z","caller":"traceutil/trace.go:171","msg":"trace[1712443435] range","detail":"{range_begin:/registry/deployments/capi-kubeadm-bootstrap-system/capi-kubeadm-bootstrap-controller-manager; range_end:; response_count:1; response_revision:23986; }","duration":"115.546672ms","start":"2026-10-14T14:24:03.635785Z","end":"2026-10-14T14:24:03.751331Z","steps":["trace[1712443435] 'agreement among raft nodes before linearized reading' (duration: 115.481821ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:24:10.245008Z","caller":"traceutil/trace.go:171","msg":"trace[693424696] transaction","detail":"{read_only:false; response_revision:24283; number_of_response:1; }","duration":"231.383415ms","start":"2026-10-14T14:24:10.013592Z","end":"2026-10-14T14:24:10.244976Z","steps":["trace[693424696] 'process raft request' (duration: 222.893591ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:24:10.248483Z","caller":"traceutil/trace.go:171","msg":"trace[457792858] transaction","detail":"{read_only:false; response_revision:24284; number_of_response:1; }","duration":"125.446635ms","start":"2026-10-14T14:24:10.123004Z","end":"2026-10-14T14:24:10.24845Z","steps":["trace[457792858] 'process raft request' (duration: 124.973262ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:24:42.765612Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21685} {"level":"info","ts":"2026-10-14T14:24:42.878758Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21685,"took":"109.420585ms","hash":1261632766,"current-db-size-bytes":57327616,"current-db-size":"57 MB","current-db-size-in-use-bytes":41914368,"current-db-size-in-use":"42 MB"} {"level":"info","ts":"2026-10-14T14:24:42.878851Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1261632766,"revision":21685,"compact-revision":19658} {"level":"info","ts":"2026-10-14T14:27:02.484355Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000068f4.wal"} {"level":"info","ts":"2026-10-14T14:27:47.21434Z","caller":"traceutil/trace.go:171","msg":"trace[1339819739] transaction","detail":"{read_only:false; response_revision:26423; number_of_response:1; }","duration":"132.337725ms","start":"2026-10-14T14:27:47.08191Z","end":"2026-10-14T14:27:47.214248Z","steps":["trace[1339819739] 'process raft request' (duration: 132.111628ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:27:47.241067Z","caller":"traceutil/trace.go:171","msg":"trace[503141893] transaction","detail":"{read_only:false; response_revision:26424; number_of_response:1; }","duration":"133.377592ms","start":"2026-10-14T14:27:47.107665Z","end":"2026-10-14T14:27:47.241042Z","steps":["trace[503141893] 'process raft request' (duration: 133.112475ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:27:47.530874Z","caller":"traceutil/trace.go:171","msg":"trace[360588577] linearizableReadLoop","detail":"{readStateIndex:27300; appliedIndex:27299; }","duration":"288.542084ms","start":"2026-10-14T14:27:47.2423Z","end":"2026-10-14T14:27:47.530842Z","steps":["trace[360588577] 'read index received' (duration: 189.133514ms)","trace[360588577] 'applied index is now lower than readState.Index' (duration: 99.40696ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T14:27:47.531293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.964305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-14T14:27:47.531327Z","caller":"traceutil/trace.go:171","msg":"trace[1648607698] transaction","detail":"{read_only:false; response_revision:26425; number_of_response:1; }","duration":"293.441859ms","start":"2026-10-14T14:27:47.237844Z","end":"2026-10-14T14:27:47.531285Z","steps":["trace[1648607698] 'process raft request' (duration: 193.608247ms)","trace[1648607698] 'compare' (duration: 99.254986ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T14:27:47.531441Z","caller":"traceutil/trace.go:171","msg":"trace[1478545088] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26425; }","duration":"289.12633ms","start":"2026-10-14T14:27:47.242263Z","end":"2026-10-14T14:27:47.53139Z","steps":["trace[1478545088] 'agreement among raft nodes before linearized reading' (duration: 288.937364ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:27:47.531505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.57291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-10-14T14:27:47.531637Z","caller":"traceutil/trace.go:171","msg":"trace[670435433] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26425; }","duration":"160.747515ms","start":"2026-10-14T14:27:47.370865Z","end":"2026-10-14T14:27:47.531613Z","steps":["trace[670435433] 'agreement among raft nodes before linearized reading' (duration: 160.436706ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:27:47.813521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.533746ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-14T14:27:47.813746Z","caller":"traceutil/trace.go:171","msg":"trace[1345615031] linearizableReadLoop","detail":"{readStateIndex:27301; appliedIndex:27300; }","duration":"256.073822ms","start":"2026-10-14T14:27:47.557657Z","end":"2026-10-14T14:27:47.813731Z","steps":["trace[1345615031] 'read index received' (duration: 133.151357ms)","trace[1345615031] 'applied index is now lower than readState.Index' (duration: 122.872664ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T14:27:47.813707Z","caller":"traceutil/trace.go:171","msg":"trace[1160870759] transaction","detail":"{read_only:false; response_revision:26426; number_of_response:1; }","duration":"278.013915ms","start":"2026-10-14T14:27:47.535639Z","end":"2026-10-14T14:27:47.813653Z","steps":["trace[1160870759] 'process raft request' (duration: 155.275945ms)","trace[1160870759] 'compare' (duration: 122.34683ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T14:27:47.813859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.202486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-14T14:27:47.813886Z","caller":"traceutil/trace.go:171","msg":"trace[1902896008] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:26426; }","duration":"256.234867ms","start":"2026-10-14T14:27:47.557644Z","end":"2026-10-14T14:27:47.813879Z","steps":["trace[1902896008] 'agreement among raft nodes before linearized reading' (duration: 256.169785ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:27:47.814474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.553894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:419189"} {"level":"info","ts":"2026-10-14T14:27:47.814594Z","caller":"traceutil/trace.go:171","msg":"trace[1957767859] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:26427; }","duration":"249.713158ms","start":"2026-10-14T14:27:47.564837Z","end":"2026-10-14T14:27:47.81455Z","steps":["trace[1957767859] 'agreement among raft nodes before linearized reading' (duration: 249.300267ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:28:47.706144Z","caller":"traceutil/trace.go:171","msg":"trace[1096487013] transaction","detail":"{read_only:false; response_revision:26973; number_of_response:1; }","duration":"119.590444ms","start":"2026-10-14T14:28:47.586534Z","end":"2026-10-14T14:28:47.706125Z","steps":["trace[1096487013] 'process raft request' (duration: 119.46853ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:28:48.262033Z","caller":"traceutil/trace.go:171","msg":"trace[235038355] transaction","detail":"{read_only:false; response_revision:26974; number_of_response:1; }","duration":"362.714291ms","start":"2026-10-14T14:28:47.899297Z","end":"2026-10-14T14:28:48.262011Z","steps":["trace[235038355] 'process raft request' (duration: 362.404192ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:28:48.262158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T14:28:47.899265Z","time spent":"362.825554ms","remote":"127.0.0.1:53346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419247,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T14:28:48.609374Z","caller":"traceutil/trace.go:171","msg":"trace[515432542] transaction","detail":"{read_only:false; response_revision:26975; number_of_response:1; }","duration":"692.677873ms","start":"2026-10-14T14:28:47.916653Z","end":"2026-10-14T14:28:48.609331Z","steps":["trace[515432542] 'process raft request' (duration: 601.876089ms)","trace[515432542] 'compare' (duration: 90.231758ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T14:28:48.609463Z","caller":"traceutil/trace.go:171","msg":"trace[1246762747] linearizableReadLoop","detail":"{readStateIndex:27863; appliedIndex:27861; }","duration":"486.593093ms","start":"2026-10-14T14:28:48.122825Z","end":"2026-10-14T14:28:48.609418Z","steps":["trace[1246762747] 'read index received' (duration: 138.874854ms)","trace[1246762747] 'applied index is now lower than readState.Index' (duration: 347.716029ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T14:28:48.609608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T14:28:47.91663Z","time spent":"692.826576ms","remote":"127.0.0.1:59156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":628,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T14:28:48.609822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.968753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-10-14T14:28:48.60996Z","caller":"traceutil/trace.go:171","msg":"trace[551148648] transaction","detail":"{read_only:false; response_revision:26976; number_of_response:1; }","duration":"480.063954ms","start":"2026-10-14T14:28:48.129877Z","end":"2026-10-14T14:28:48.609941Z","steps":["trace[551148648] 'process raft request' (duration: 479.361244ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:28:48.609959Z","caller":"traceutil/trace.go:171","msg":"trace[598459818] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26976; }","duration":"487.139158ms","start":"2026-10-14T14:28:48.122792Z","end":"2026-10-14T14:28:48.609932Z","steps":["trace[598459818] 'agreement among raft nodes before linearized reading' (duration: 486.861561ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:28:48.610165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T14:28:48.122778Z","time spent":"487.347044ms","remote":"127.0.0.1:59156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-14T14:28:48.610274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T14:28:48.129867Z","time spent":"480.157966ms","remote":"127.0.0.1:59156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T14:28:48.612545Z","caller":"traceutil/trace.go:171","msg":"trace[1299519604] transaction","detail":"{read_only:false; response_revision:26977; number_of_response:1; }","duration":"240.604797ms","start":"2026-10-14T14:28:48.371907Z","end":"2026-10-14T14:28:48.612512Z","steps":["trace[1299519604] 'process raft request' (duration: 239.693032ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:28:48.62277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.380572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/images/\" range_end:\"/registry/openstack.k-orc.cloud/images0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-14T14:28:48.622807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.472002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-10-14T14:28:48.622892Z","caller":"traceutil/trace.go:171","msg":"trace[1951588539] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26978; }","duration":"422.579895ms","start":"2026-10-14T14:28:48.200282Z","end":"2026-10-14T14:28:48.622862Z","steps":["trace[1951588539] 'agreement among raft nodes before linearized reading' (duration: 422.37128ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:28:48.622831Z","caller":"traceutil/trace.go:171","msg":"trace[1975538252] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/images/; range_end:/registry/openstack.k-orc.cloud/images0; response_count:0; response_revision:26978; }","duration":"283.450524ms","start":"2026-10-14T14:28:48.339364Z","end":"2026-10-14T14:28:48.622815Z","steps":["trace[1975538252] 'agreement among raft nodes before linearized reading' (duration: 283.343671ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:28:48.622955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T14:28:48.200266Z","time spent":"422.675727ms","remote":"127.0.0.1:59156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-14T14:28:48.623043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.33875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-14T14:28:48.623184Z","caller":"traceutil/trace.go:171","msg":"trace[933537597] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:26978; }","duration":"303.539916ms","start":"2026-10-14T14:28:48.31961Z","end":"2026-10-14T14:28:48.62315Z","steps":["trace[933537597] 'agreement among raft nodes before linearized reading' (duration: 303.224038ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:28:48.622826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.723387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"warn","ts":"2026-10-14T14:28:48.623243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T14:28:48.319597Z","time spent":"303.634678ms","remote":"127.0.0.1:46038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true "} {"level":"info","ts":"2026-10-14T14:28:48.623263Z","caller":"traceutil/trace.go:171","msg":"trace[1033016153] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26978; }","duration":"203.19862ms","start":"2026-10-14T14:28:48.420047Z","end":"2026-10-14T14:28:48.623245Z","steps":["trace[1033016153] 'agreement among raft nodes before linearized reading' (duration: 202.622334ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T14:28:48.623772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.599603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-14T14:28:48.623904Z","caller":"traceutil/trace.go:171","msg":"trace[1972951294] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26978; }","duration":"206.808589ms","start":"2026-10-14T14:28:48.417066Z","end":"2026-10-14T14:28:48.623875Z","steps":["trace[1972951294] 'agreement among raft nodes before linearized reading' (duration: 205.788221ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:28:48.804946Z","caller":"traceutil/trace.go:171","msg":"trace[109773404] transaction","detail":"{read_only:false; response_revision:26979; number_of_response:1; }","duration":"189.500614ms","start":"2026-10-14T14:28:48.61539Z","end":"2026-10-14T14:28:48.804891Z","steps":["trace[109773404] 'process raft request' (duration: 129.798404ms)","trace[109773404] 'compare' (duration: 59.442513ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T14:28:48.805179Z","caller":"traceutil/trace.go:171","msg":"trace[358020543] transaction","detail":"{read_only:false; response_revision:26980; number_of_response:1; }","duration":"176.067425ms","start":"2026-10-14T14:28:48.629086Z","end":"2026-10-14T14:28:48.805153Z","steps":["trace[358020543] 'process raft request' (duration: 175.742636ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:28:48.805342Z","caller":"traceutil/trace.go:171","msg":"trace[1480407392] transaction","detail":"{read_only:false; response_revision:26981; number_of_response:1; }","duration":"174.632186ms","start":"2026-10-14T14:28:48.63069Z","end":"2026-10-14T14:28:48.805323Z","steps":["trace[1480407392] 'process raft request' (duration: 174.369709ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:28:48.80555Z","caller":"traceutil/trace.go:171","msg":"trace[188737973] transaction","detail":"{read_only:false; response_revision:26982; number_of_response:1; }","duration":"174.815341ms","start":"2026-10-14T14:28:48.630724Z","end":"2026-10-14T14:28:48.805539Z","steps":["trace[188737973] 'process raft request' (duration: 174.549004ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:29:42.774806Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24624} {"level":"info","ts":"2026-10-14T14:29:42.922976Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24624,"took":"143.387422ms","hash":2954955475,"current-db-size-bytes":58593280,"current-db-size":"59 MB","current-db-size-in-use-bytes":36741120,"current-db-size-in-use":"37 MB"} {"level":"info","ts":"2026-10-14T14:29:42.923049Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2954955475,"revision":24624,"compact-revision":21685} {"level":"info","ts":"2026-10-14T14:32:23.615538Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b3aa5b67741e7c5e","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-14T14:32:23.621325Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-10-14T14:32:23.621406Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-10-14T14:32:45.847951Z","caller":"traceutil/trace.go:171","msg":"trace[1133190872] transaction","detail":"{read_only:false; response_revision:29262; number_of_response:1; }","duration":"106.794136ms","start":"2026-10-14T14:32:45.741131Z","end":"2026-10-14T14:32:45.847925Z","steps":["trace[1133190872] 'process raft request' (duration: 106.603201ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:32:45.896168Z","caller":"traceutil/trace.go:171","msg":"trace[2015621092] transaction","detail":"{read_only:false; response_revision:29263; number_of_response:1; }","duration":"144.699507ms","start":"2026-10-14T14:32:45.751439Z","end":"2026-10-14T14:32:45.896139Z","steps":["trace[2015621092] 'process raft request' (duration: 106.309332ms)","trace[2015621092] 'compare' (duration: 38.098567ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T14:32:45.896499Z","caller":"traceutil/trace.go:171","msg":"trace[1592678866] linearizableReadLoop","detail":"{readStateIndex:30208; appliedIndex:30206; }","duration":"115.129675ms","start":"2026-10-14T14:32:45.781334Z","end":"2026-10-14T14:32:45.896463Z","steps":["trace[1592678866] 'read index received' (duration: 66.020595ms)","trace[1592678866] 'applied index is now lower than readState.Index' (duration: 49.10788ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T14:32:45.896677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.308049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/addressscopes/\" range_end:\"/registry/openstack.k-orc.cloud/addressscopes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-14T14:32:45.896786Z","caller":"traceutil/trace.go:171","msg":"trace[2135697117] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/addressscopes/; range_end:/registry/openstack.k-orc.cloud/addressscopes0; response_count:0; response_revision:29265; }","duration":"115.498815ms","start":"2026-10-14T14:32:45.781257Z","end":"2026-10-14T14:32:45.896756Z","steps":["trace[2135697117] 'agreement among raft nodes before linearized reading' (duration: 115.32112ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:34:42.786472Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27549} {"level":"info","ts":"2026-10-14T14:34:42.95315Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27549,"took":"160.589254ms","hash":2426992865,"current-db-size-bytes":58593280,"current-db-size":"59 MB","current-db-size-in-use-bytes":35180544,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-10-14T14:34:42.953243Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2426992865,"revision":27549,"compact-revision":24624} {"level":"info","ts":"2026-10-14T14:39:42.800294Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30250} {"level":"info","ts":"2026-10-14T14:39:42.991071Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30250,"took":"186.32172ms","hash":1158055452,"current-db-size-bytes":58593280,"current-db-size":"59 MB","current-db-size-in-use-bytes":30789632,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-14T14:39:42.991168Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1158055452,"revision":30250,"compact-revision":27549} {"level":"info","ts":"2026-10-14T14:44:42.805947Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32502} {"level":"info","ts":"2026-10-14T14:44:42.964981Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32502,"took":"154.839235ms","hash":2672449262,"current-db-size-bytes":59637760,"current-db-size":"60 MB","current-db-size-in-use-bytes":30306304,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-14T14:44:42.965076Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2672449262,"revision":32502,"compact-revision":30250} {"level":"info","ts":"2026-10-14T14:45:34.532233Z","caller":"traceutil/trace.go:171","msg":"trace[892502481] transaction","detail":"{read_only:false; response_revision:35141; number_of_response:1; }","duration":"123.841663ms","start":"2026-10-14T14:45:34.408362Z","end":"2026-10-14T14:45:34.532203Z","steps":["trace[892502481] 'process raft request' (duration: 108.578183ms)","trace[892502481] 'compare' (duration: 14.819868ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T14:45:34.532354Z","caller":"traceutil/trace.go:171","msg":"trace[121515261] linearizableReadLoop","detail":"{readStateIndex:36252; appliedIndex:36251; }","duration":"119.915015ms","start":"2026-10-14T14:45:34.412406Z","end":"2026-10-14T14:45:34.532321Z","steps":["trace[121515261] 'read index received' (duration: 103.70788ms)","trace[121515261] 'applied index is now lower than readState.Index' (duration: 16.204385ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T14:45:34.532592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.164542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-10-14T14:45:34.532632Z","caller":"traceutil/trace.go:171","msg":"trace[1864546889] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:35142; }","duration":"120.216943ms","start":"2026-10-14T14:45:34.412401Z","end":"2026-10-14T14:45:34.532618Z","steps":["trace[1864546889] 'agreement among raft nodes before linearized reading' (duration: 120.021088ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:49:42.816576Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34729} {"level":"info","ts":"2026-10-14T14:49:42.955166Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34729,"took":"134.353652ms","hash":1799552235,"current-db-size-bytes":59637760,"current-db-size":"60 MB","current-db-size-in-use-bytes":31252480,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-14T14:49:42.955252Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1799552235,"revision":34729,"compact-revision":32502} {"level":"info","ts":"2026-10-14T14:51:00.640692Z","caller":"traceutil/trace.go:171","msg":"trace[1403069007] transaction","detail":"{read_only:false; response_revision:37676; number_of_response:1; }","duration":"104.354087ms","start":"2026-10-14T14:51:00.53631Z","end":"2026-10-14T14:51:00.640664Z","steps":["trace[1403069007] 'process raft request' (duration: 104.202313ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T14:53:34.363018Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b3aa5b67741e7c5e","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-14T14:53:34.369516Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-10-14T14:53:34.369663Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-10-14T14:54:42.822671Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37022} {"level":"info","ts":"2026-10-14T14:54:42.939701Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37022,"took":"113.313703ms","hash":1582549147,"current-db-size-bytes":59637760,"current-db-size":"60 MB","current-db-size-in-use-bytes":33087488,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-14T14:54:42.939744Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1582549147,"revision":37022,"compact-revision":34729} {"level":"info","ts":"2026-10-14T14:59:42.829932Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39293} {"level":"info","ts":"2026-10-14T14:59:42.966908Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39293,"took":"133.801357ms","hash":3575382255,"current-db-size-bytes":59637760,"current-db-size":"60 MB","current-db-size-in-use-bytes":31326208,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-14T14:59:42.966955Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3575382255,"revision":39293,"compact-revision":37022}