{"level":"warn","ts":"2026-10-16T00:09:31.563706Z","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-16T00:09:31.563906Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.128:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.128:2380","--initial-cluster=instance=https://162.253.55.128:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.128:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.128: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-16T00:09:31.564037Z","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-16T00:09:31.564064Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.128:2380"]} {"level":"info","ts":"2026-10-16T00:09:31.564106Z","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-16T00:09:31.565505Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.128:2379"]} {"level":"info","ts":"2026-10-16T00:09:31.565659Z","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://162.253.55.128:2380"],"listen-peer-urls":["https://162.253.55.128:2380"],"advertise-client-urls":["https://162.253.55.128:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.128:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.128: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-16T00:09:31.570337Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.252417ms"} {"level":"info","ts":"2026-10-16T00:09:31.579614Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e3e8b7bea2e3a32b","cluster-id":"ca619600f96ab468"} {"level":"info","ts":"2026-10-16T00:09:31.579742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3e8b7bea2e3a32b switched to configuration voters=()"} {"level":"info","ts":"2026-10-16T00:09:31.579774Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3e8b7bea2e3a32b became follower at term 0"} {"level":"info","ts":"2026-10-16T00:09:31.579796Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e3e8b7bea2e3a32b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-16T00:09:31.579814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3e8b7bea2e3a32b became follower at term 1"} {"level":"info","ts":"2026-10-16T00:09:31.579892Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3e8b7bea2e3a32b switched to configuration voters=(16422578070611010347)"} {"level":"warn","ts":"2026-10-16T00:09:31.585903Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-16T00:09:31.587999Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-16T00:09:31.589424Z","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-16T00:09:31.592237Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e3e8b7bea2e3a32b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-16T00:09:31.592448Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e3e8b7bea2e3a32b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-16T00:09:31.592564Z","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-16T00:09:31.592628Z","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-16T00:09:31.592637Z","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-16T00:09:31.594708Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3e8b7bea2e3a32b switched to configuration voters=(16422578070611010347)"} {"level":"info","ts":"2026-10-16T00:09:31.595069Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ca619600f96ab468","local-member-id":"e3e8b7bea2e3a32b","added-peer-id":"e3e8b7bea2e3a32b","added-peer-peer-urls":["https://162.253.55.128:2380"]} {"level":"info","ts":"2026-10-16T00:09:31.599478Z","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-16T00:09:31.599854Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e3e8b7bea2e3a32b","initial-advertise-peer-urls":["https://162.253.55.128:2380"],"listen-peer-urls":["https://162.253.55.128:2380"],"advertise-client-urls":["https://162.253.55.128:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.128:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-16T00:09:31.599906Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-16T00:09:31.600073Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.128:2380"} {"level":"info","ts":"2026-10-16T00:09:31.600095Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.128:2380"} {"level":"info","ts":"2026-10-16T00:09:32.280349Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3e8b7bea2e3a32b is starting a new election at term 1"} {"level":"info","ts":"2026-10-16T00:09:32.280433Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3e8b7bea2e3a32b became pre-candidate at term 1"} {"level":"info","ts":"2026-10-16T00:09:32.280497Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3e8b7bea2e3a32b received MsgPreVoteResp from e3e8b7bea2e3a32b at term 1"} {"level":"info","ts":"2026-10-16T00:09:32.28052Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3e8b7bea2e3a32b became candidate at term 2"} {"level":"info","ts":"2026-10-16T00:09:32.280531Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3e8b7bea2e3a32b received MsgVoteResp from e3e8b7bea2e3a32b at term 2"} {"level":"info","ts":"2026-10-16T00:09:32.280547Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3e8b7bea2e3a32b became leader at term 2"} {"level":"info","ts":"2026-10-16T00:09:32.280573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e3e8b7bea2e3a32b elected leader e3e8b7bea2e3a32b at term 2"} {"level":"info","ts":"2026-10-16T00:09:32.281924Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-16T00:09:32.282654Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e3e8b7bea2e3a32b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.128:2379]}","request-path":"/0/members/e3e8b7bea2e3a32b/attributes","cluster-id":"ca619600f96ab468","publish-timeout":"7s"} {"level":"info","ts":"2026-10-16T00:09:32.282675Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-16T00:09:32.282737Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-16T00:09:32.283059Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-16T00:09:32.283124Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-16T00:09:32.283278Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ca619600f96ab468","local-member-id":"e3e8b7bea2e3a32b","cluster-version":"3.5"} {"level":"info","ts":"2026-10-16T00:09:32.283414Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-16T00:09:32.28347Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-16T00:09:32.287521Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.128:2379"} {"level":"info","ts":"2026-10-16T00:09:32.287555Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-16T00:09:57.185409Z","caller":"traceutil/trace.go:171","msg":"trace[1870870944] transaction","detail":"{read_only:false; response_revision:433; number_of_response:1; }","duration":"114.81327ms","start":"2026-10-16T00:09:57.070561Z","end":"2026-10-16T00:09:57.185374Z","steps":["trace[1870870944] 'process raft request' (duration: 96.277242ms)","trace[1870870944] 'compare' (duration: 18.415965ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:10:06.021604Z","caller":"traceutil/trace.go:171","msg":"trace[765375695] linearizableReadLoop","detail":"{readStateIndex:503; appliedIndex:502; }","duration":"119.798489ms","start":"2026-10-16T00:10:05.901772Z","end":"2026-10-16T00:10:06.02157Z","steps":["trace[765375695] 'read index received' (duration: 30.808316ms)","trace[765375695] 'applied index is now lower than readState.Index' (duration: 88.988933ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:10:06.021642Z","caller":"traceutil/trace.go:171","msg":"trace[2076741446] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"120.7388ms","start":"2026-10-16T00:10:05.900879Z","end":"2026-10-16T00:10:06.021618Z","steps":["trace[2076741446] 'process raft request' (duration: 31.736627ms)","trace[2076741446] 'compare' (duration: 88.844109ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:10:06.021918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.091166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-10-16T00:10:06.022105Z","caller":"traceutil/trace.go:171","msg":"trace[706376396] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:484; }","duration":"120.326431ms","start":"2026-10-16T00:10:05.901746Z","end":"2026-10-16T00:10:06.022072Z","steps":["trace[706376396] 'agreement among raft nodes before linearized reading' (duration: 119.954973ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:10:18.734609Z","caller":"traceutil/trace.go:171","msg":"trace[1177903053] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"122.954529ms","start":"2026-10-16T00:10:18.611631Z","end":"2026-10-16T00:10:18.734585Z","steps":["trace[1177903053] 'process raft request' (duration: 122.811225ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:10:18.968615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.039683ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-16T00:10:18.970152Z","caller":"traceutil/trace.go:171","msg":"trace[1906661708] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"180.90265ms","start":"2026-10-16T00:10:18.787933Z","end":"2026-10-16T00:10:18.968836Z","steps":["trace[1906661708] 'process raft request' (duration: 180.755256ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:10:18.968803Z","caller":"traceutil/trace.go:171","msg":"trace[125798554] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"180.90639ms","start":"2026-10-16T00:10:18.787852Z","end":"2026-10-16T00:10:18.968758Z","steps":["trace[125798554] 'process raft request' (duration: 50.344935ms)","trace[125798554] 'compare' (duration: 129.729607ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:10:18.971801Z","caller":"traceutil/trace.go:171","msg":"trace[1572897914] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"175.236585ms","start":"2026-10-16T00:10:18.796541Z","end":"2026-10-16T00:10:18.971778Z","steps":["trace[1572897914] 'process raft request' (duration: 172.853283ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:10:18.96998Z","caller":"traceutil/trace.go:171","msg":"trace[1287346210] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"181.278828ms","start":"2026-10-16T00:10:18.78834Z","end":"2026-10-16T00:10:18.969619Z","steps":["trace[1287346210] 'process raft request' (duration: 180.403519ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:10:18.973073Z","caller":"traceutil/trace.go:171","msg":"trace[1400899734] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"183.128618ms","start":"2026-10-16T00:10:18.78975Z","end":"2026-10-16T00:10:18.972879Z","steps":["trace[1400899734] 'process raft request' (duration: 179.014008ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:10:18.973748Z","caller":"traceutil/trace.go:171","msg":"trace[1713573609] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"168.122039ms","start":"2026-10-16T00:10:18.805543Z","end":"2026-10-16T00:10:18.973665Z","steps":["trace[1713573609] 'process raft request' (duration: 167.725981ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:10:18.97414Z","caller":"traceutil/trace.go:171","msg":"trace[1321959543] transaction","detail":"{read_only:false; number_of_response:1; response_revision:563; }","duration":"183.324552ms","start":"2026-10-16T00:10:18.789927Z","end":"2026-10-16T00:10:18.973252Z","steps":["trace[1321959543] 'process raft request' (duration: 178.875275ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:10:18.97627Z","caller":"traceutil/trace.go:171","msg":"trace[1541303205] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"156.523695ms","start":"2026-10-16T00:10:18.819715Z","end":"2026-10-16T00:10:18.976239Z","steps":["trace[1541303205] 'process raft request' (duration: 154.044981ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:10:18.976341Z","caller":"traceutil/trace.go:171","msg":"trace[988211587] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"154.999391ms","start":"2026-10-16T00:10:18.821324Z","end":"2026-10-16T00:10:18.976323Z","steps":["trace[988211587] 'process raft request' (duration: 154.834637ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:10:18.976415Z","caller":"traceutil/trace.go:171","msg":"trace[672064702] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"142.015256ms","start":"2026-10-16T00:10:18.834374Z","end":"2026-10-16T00:10:18.976389Z","steps":["trace[672064702] 'process raft request' (duration: 141.930394ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:10:18.976441Z","caller":"traceutil/trace.go:171","msg":"trace[914391482] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"148.935478ms","start":"2026-10-16T00:10:18.827487Z","end":"2026-10-16T00:10:18.976423Z","steps":["trace[914391482] 'process raft request' (duration: 148.731524ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:10:19.136965Z","caller":"traceutil/trace.go:171","msg":"trace[1624818028] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"120.178417ms","start":"2026-10-16T00:10:19.016754Z","end":"2026-10-16T00:10:19.136932Z","steps":["trace[1624818028] 'process raft request' (duration: 97.795786ms)","trace[1624818028] 'compare' (duration: 22.122095ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:10:19.383441Z","caller":"traceutil/trace.go:171","msg":"trace[798380884] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"141.73726ms","start":"2026-10-16T00:10:19.241646Z","end":"2026-10-16T00:10:19.383384Z","steps":["trace[798380884] 'process raft request' (duration: 141.317021ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:10:19.383507Z","caller":"traceutil/trace.go:171","msg":"trace[207457326] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"129.245316ms","start":"2026-10-16T00:10:19.254204Z","end":"2026-10-16T00:10:19.383449Z","steps":["trace[207457326] 'process raft request' (duration: 129.049951ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:10:19.421165Z","caller":"traceutil/trace.go:171","msg":"trace[1304225614] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"108.038731ms","start":"2026-10-16T00:10:19.313099Z","end":"2026-10-16T00:10:19.421138Z","steps":["trace[1304225614] 'process raft request' (duration: 86.565879ms)","trace[1304225614] 'compare' (duration: 20.686374ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:10:19.61585Z","caller":"traceutil/trace.go:171","msg":"trace[1786600358] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"130.602116ms","start":"2026-10-16T00:10:19.485186Z","end":"2026-10-16T00:10:19.615788Z","steps":["trace[1786600358] 'process raft request' (duration: 82.91327ms)","trace[1786600358] 'compare' (duration: 47.487812ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:10:19.617433Z","caller":"traceutil/trace.go:171","msg":"trace[991586035] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"129.170775ms","start":"2026-10-16T00:10:19.488243Z","end":"2026-10-16T00:10:19.617414Z","steps":["trace[991586035] 'process raft request' (duration: 128.932369ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:10:19.617451Z","caller":"traceutil/trace.go:171","msg":"trace[1680113003] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"121.689231ms","start":"2026-10-16T00:10:19.495737Z","end":"2026-10-16T00:10:19.617427Z","steps":["trace[1680113003] 'process raft request' (duration: 121.611209ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:10:19.801756Z","caller":"traceutil/trace.go:171","msg":"trace[1047975116] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"120.368671ms","start":"2026-10-16T00:10:19.68135Z","end":"2026-10-16T00:10:19.801719Z","steps":["trace[1047975116] 'process raft request' (duration: 93.008021ms)","trace[1047975116] 'compare' (duration: 27.197386ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:10:19.849481Z","caller":"traceutil/trace.go:171","msg":"trace[26194801] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"115.29419ms","start":"2026-10-16T00:10:19.734144Z","end":"2026-10-16T00:10:19.849439Z","steps":["trace[26194801] 'process raft request' (duration: 115.096316ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:10:26.481377Z","caller":"traceutil/trace.go:171","msg":"trace[2145571884] linearizableReadLoop","detail":"{readStateIndex:683; appliedIndex:682; }","duration":"306.159808ms","start":"2026-10-16T00:10:26.175188Z","end":"2026-10-16T00:10:26.481347Z","steps":["trace[2145571884] 'read index received' (duration: 305.33512ms)","trace[2145571884] 'applied index is now lower than readState.Index' (duration: 823.658µs)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:10:26.481517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.326432ms","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-16T00:10:26.481482Z","caller":"traceutil/trace.go:171","msg":"trace[136178473] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"337.888484ms","start":"2026-10-16T00:10:26.143546Z","end":"2026-10-16T00:10:26.481434Z","steps":["trace[136178473] 'process raft request' (duration: 337.191169ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:10:26.481557Z","caller":"traceutil/trace.go:171","msg":"trace[1282791677] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:658; }","duration":"306.413363ms","start":"2026-10-16T00:10:26.175128Z","end":"2026-10-16T00:10:26.481541Z","steps":["trace[1282791677] 'agreement among raft nodes before linearized reading' (duration: 306.324491ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:10:26.481596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:10:26.175064Z","time spent":"306.524836ms","remote":"127.0.0.1:39558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-16T00:10:26.482024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:10:26.143515Z","time spent":"338.083058ms","remote":"127.0.0.1:39400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036273,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T00:10:27.151272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.000141ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-16T00:10:27.151379Z","caller":"traceutil/trace.go:171","msg":"trace[664282484] linearizableReadLoop","detail":"{readStateIndex:685; appliedIndex:684; }","duration":"380.673623ms","start":"2026-10-16T00:10:26.770688Z","end":"2026-10-16T00:10:27.151362Z","steps":["trace[664282484] 'read index received' (duration: 240.489457ms)","trace[664282484] 'applied index is now lower than readState.Index' (duration: 140.182966ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:10:27.151487Z","caller":"traceutil/trace.go:171","msg":"trace[1547648629] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"590.1586ms","start":"2026-10-16T00:10:26.561296Z","end":"2026-10-16T00:10:27.151455Z","steps":["trace[1547648629] 'process raft request' (duration: 449.905093ms)","trace[1547648629] 'compare' (duration: 139.810598ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:10:27.151552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:10:26.561266Z","time spent":"590.257492ms","remote":"127.0.0.1:39774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-16T00:10:27.152064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.363478ms","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-16T00:10:27.152152Z","caller":"traceutil/trace.go:171","msg":"trace[441706266] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:660; }","duration":"381.45929ms","start":"2026-10-16T00:10:26.770665Z","end":"2026-10-16T00:10:27.152124Z","steps":["trace[441706266] 'agreement among raft nodes before linearized reading' (duration: 381.205124ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:10:27.152195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:10:26.770578Z","time spent":"381.608553ms","remote":"127.0.0.1:39558","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-16T00:10:43.12123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.249867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:10:43.121352Z","caller":"traceutil/trace.go:171","msg":"trace[1931974064] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:824; }","duration":"335.43703ms","start":"2026-10-16T00:10:42.78589Z","end":"2026-10-16T00:10:43.121327Z","steps":["trace[1931974064] 'count revisions from in-memory index tree' (duration: 335.164315ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:10:43.121337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.54492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-16T00:10:43.121416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:10:42.785874Z","time spent":"335.522213ms","remote":"127.0.0.1:52184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"info","ts":"2026-10-16T00:10:43.121446Z","caller":"traceutil/trace.go:171","msg":"trace[1907361398] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:824; }","duration":"272.699784ms","start":"2026-10-16T00:10:42.848719Z","end":"2026-10-16T00:10:43.121418Z","steps":["trace[1907361398] 'count revisions from in-memory index tree' (duration: 272.482209ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:10:43.121687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.066058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-16T00:10:43.121724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.517253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:10:43.121755Z","caller":"traceutil/trace.go:171","msg":"trace[408486425] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:824; }","duration":"271.15331ms","start":"2026-10-16T00:10:42.850584Z","end":"2026-10-16T00:10:43.121737Z","steps":["trace[408486425] 'range keys from in-memory index tree' (duration: 271.015887ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:10:43.12177Z","caller":"traceutil/trace.go:171","msg":"trace[406614501] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:824; }","duration":"335.570794ms","start":"2026-10-16T00:10:42.786185Z","end":"2026-10-16T00:10:43.121756Z","steps":["trace[406614501] 'range keys from in-memory index tree' (duration: 335.383059ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:10:43.121856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:10:42.786136Z","time spent":"335.662886ms","remote":"127.0.0.1:52184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 "} {"level":"warn","ts":"2026-10-16T00:10:43.121902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.224612ms","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:5"} {"level":"info","ts":"2026-10-16T00:10:43.121935Z","caller":"traceutil/trace.go:171","msg":"trace[1576529076] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:824; }","duration":"204.272072ms","start":"2026-10-16T00:10:42.917651Z","end":"2026-10-16T00:10:43.121923Z","steps":["trace[1576529076] 'count revisions from in-memory index tree' (duration: 204.18779ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:10:43.12194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.459299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-16T00:10:43.121953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.639254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:10:43.121995Z","caller":"traceutil/trace.go:171","msg":"trace[327568970] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:824; }","duration":"293.715736ms","start":"2026-10-16T00:10:42.828268Z","end":"2026-10-16T00:10:43.121983Z","steps":["trace[327568970] 'range keys from in-memory index tree' (duration: 293.542232ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:10:43.12205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.534872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:10:43.122078Z","caller":"traceutil/trace.go:171","msg":"trace[1643588420] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:824; }","duration":"252.614674ms","start":"2026-10-16T00:10:42.869454Z","end":"2026-10-16T00:10:43.122069Z","steps":["trace[1643588420] 'range keys from in-memory index tree' (duration: 252.339617ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:10:43.122086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.494268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:10:43.122113Z","caller":"traceutil/trace.go:171","msg":"trace[154210587] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:824; }","duration":"204.545788ms","start":"2026-10-16T00:10:42.917559Z","end":"2026-10-16T00:10:43.122105Z","steps":["trace[154210587] 'range keys from in-memory index tree' (duration: 204.351335ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:10:43.122105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.543642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:10:43.122185Z","caller":"traceutil/trace.go:171","msg":"trace[1692040195] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:824; }","duration":"273.626764ms","start":"2026-10-16T00:10:42.848517Z","end":"2026-10-16T00:10:43.122144Z","steps":["trace[1692040195] 'range keys from in-memory index tree' (duration: 273.477801ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:10:43.122226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.865874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-16T00:10:43.122205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.252717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-16T00:10:43.122241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.40007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:10:43.122252Z","caller":"traceutil/trace.go:171","msg":"trace[328974288] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:824; }","duration":"203.905744ms","start":"2026-10-16T00:10:42.918337Z","end":"2026-10-16T00:10:43.122243Z","steps":["trace[328974288] 'range keys from in-memory index tree' (duration: 203.816913ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:10:43.122274Z","caller":"traceutil/trace.go:171","msg":"trace[1899818172] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:824; }","duration":"294.476492ms","start":"2026-10-16T00:10:42.827787Z","end":"2026-10-16T00:10:43.122263Z","steps":["trace[1899818172] 'count revisions from in-memory index tree' (duration: 294.343289ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:10:43.121995Z","caller":"traceutil/trace.go:171","msg":"trace[1604298154] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:824; }","duration":"252.532431ms","start":"2026-10-16T00:10:42.869442Z","end":"2026-10-16T00:10:43.121975Z","steps":["trace[1604298154] 'count revisions from in-memory index tree' (duration: 252.310646ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:10:43.122202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.452201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-16T00:10:43.121868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.502888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:10:43.122549Z","caller":"traceutil/trace.go:171","msg":"trace[518362951] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:824; }","duration":"226.240364ms","start":"2026-10-16T00:10:42.896297Z","end":"2026-10-16T00:10:43.122538Z","steps":["trace[518362951] 'range keys from in-memory index tree' (duration: 225.233452ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:10:43.122557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.92525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:10:43.122596Z","caller":"traceutil/trace.go:171","msg":"trace[1587610381] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:824; }","duration":"252.978771ms","start":"2026-10-16T00:10:42.869603Z","end":"2026-10-16T00:10:43.122582Z","steps":["trace[1587610381] 'range keys from in-memory index tree' (duration: 252.811188ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:10:43.122631Z","caller":"traceutil/trace.go:171","msg":"trace[325870647] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:824; }","duration":"315.613766ms","start":"2026-10-16T00:10:42.806643Z","end":"2026-10-16T00:10:43.122256Z","steps":["trace[325870647] 'range keys from in-memory index tree' (duration: 315.184686ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:10:43.122747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.980797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-cgr2b\" ","response":"range_response_count:1 size:3965"} {"level":"warn","ts":"2026-10-16T00:10:43.122764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.401068ms","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:5"} {"level":"info","ts":"2026-10-16T00:10:43.122782Z","caller":"traceutil/trace.go:171","msg":"trace[797076746] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-cgr2b; range_end:; response_count:1; response_revision:824; }","duration":"318.063009ms","start":"2026-10-16T00:10:42.804707Z","end":"2026-10-16T00:10:43.12277Z","steps":["trace[797076746] 'range keys from in-memory index tree' (duration: 317.699771ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:10:43.122796Z","caller":"traceutil/trace.go:171","msg":"trace[1572700117] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:824; }","duration":"226.463349ms","start":"2026-10-16T00:10:42.896322Z","end":"2026-10-16T00:10:43.122786Z","steps":["trace[1572700117] 'count revisions from in-memory index tree' (duration: 226.188803ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:10:43.122838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:10:42.804679Z","time spent":"318.151051ms","remote":"127.0.0.1:39486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3989,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-cgr2b\" "} {"level":"warn","ts":"2026-10-16T00:10:43.122791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:10:42.806629Z","time spent":"316.136267ms","remote":"127.0.0.1:52188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 "} {"level":"warn","ts":"2026-10-16T00:10:43.122991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.118025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:10:43.123048Z","caller":"traceutil/trace.go:171","msg":"trace[269238420] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:824; }","duration":"336.252339ms","start":"2026-10-16T00:10:42.786775Z","end":"2026-10-16T00:10:43.123027Z","steps":["trace[269238420] 'range keys from in-memory index tree' (duration: 335.996353ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:10:43.123107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:10:42.786746Z","time spent":"336.344211ms","remote":"127.0.0.1:52184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 "} {"level":"warn","ts":"2026-10-16T00:10:43.123175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.424146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:10:43.122501Z","caller":"traceutil/trace.go:171","msg":"trace[549757608] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:824; }","duration":"294.761829ms","start":"2026-10-16T00:10:42.827719Z","end":"2026-10-16T00:10:43.12248Z","steps":["trace[549757608] 'range keys from in-memory index tree' (duration: 294.346449ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:10:43.123218Z","caller":"traceutil/trace.go:171","msg":"trace[604630072] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:824; }","duration":"317.479666ms","start":"2026-10-16T00:10:42.805725Z","end":"2026-10-16T00:10:43.123205Z","steps":["trace[604630072] 'count revisions from in-memory index tree' (duration: 317.365974ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:10:43.123337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:10:42.805718Z","time spent":"317.604909ms","remote":"127.0.0.1:52188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"warn","ts":"2026-10-16T00:10:43.123191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.61306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:10:43.123499Z","caller":"traceutil/trace.go:171","msg":"trace[1498903382] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:824; }","duration":"317.931116ms","start":"2026-10-16T00:10:42.805543Z","end":"2026-10-16T00:10:43.123474Z","steps":["trace[1498903382] 'range keys from in-memory index tree' (duration: 317.524298ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:10:43.123618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:10:42.80553Z","time spent":"318.017748ms","remote":"127.0.0.1:52188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 "} {"level":"info","ts":"2026-10-16T00:11:14.417522Z","caller":"traceutil/trace.go:171","msg":"trace[629954986] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"233.123003ms","start":"2026-10-16T00:11:14.18436Z","end":"2026-10-16T00:11:14.417483Z","steps":["trace[629954986] 'process raft request' (duration: 232.956559ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:11:31.049226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.008307ms","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-16T00:11:31.049346Z","caller":"traceutil/trace.go:171","msg":"trace[1899995490] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1365; }","duration":"117.17555ms","start":"2026-10-16T00:11:30.932137Z","end":"2026-10-16T00:11:31.049313Z","steps":["trace[1899995490] 'range keys from in-memory index tree' (duration: 116.805382ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:12:06.311251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.220711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.128\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-10-16T00:12:06.311345Z","caller":"traceutil/trace.go:171","msg":"trace[31572341] range","detail":"{range_begin:/registry/masterleases/162.253.55.128; range_end:; response_count:1; response_revision:1912; }","duration":"588.380355ms","start":"2026-10-16T00:12:05.722944Z","end":"2026-10-16T00:12:06.311324Z","steps":["trace[31572341] 'range keys from in-memory index tree' (duration: 587.974106ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:12:06.311387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:12:05.722911Z","time spent":"588.467156ms","remote":"127.0.0.1:39316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/162.253.55.128\" "} {"level":"warn","ts":"2026-10-16T00:12:06.311364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.031822ms","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-16T00:12:06.311463Z","caller":"traceutil/trace.go:171","msg":"trace[105259952] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1912; }","duration":"481.210786ms","start":"2026-10-16T00:12:05.830226Z","end":"2026-10-16T00:12:06.311437Z","steps":["trace[105259952] 'range keys from in-memory index tree' (duration: 480.825727ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:12:06.311541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.976874ms","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-16T00:12:06.311592Z","caller":"traceutil/trace.go:171","msg":"trace[1461269937] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1912; }","duration":"454.078447ms","start":"2026-10-16T00:12:05.8575Z","end":"2026-10-16T00:12:06.311578Z","steps":["trace[1461269937] 'count revisions from in-memory index tree' (duration: 453.840821ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:12:06.311622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:12:05.857472Z","time spent":"454.141487ms","remote":"127.0.0.1:39748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":3,"response size":31,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"warn","ts":"2026-10-16T00:12:06.311527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:12:05.830193Z","time spent":"481.320068ms","remote":"127.0.0.1:39558","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-16T00:12:06.311694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.449508ms","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-16T00:12:06.311721Z","caller":"traceutil/trace.go:171","msg":"trace[938355669] linearizableReadLoop","detail":"{readStateIndex:1984; appliedIndex:1983; }","duration":"315.058994ms","start":"2026-10-16T00:12:05.996637Z","end":"2026-10-16T00:12:06.311696Z","steps":["trace[938355669] 'read index received' (duration: 228.801938ms)","trace[938355669] 'applied index is now lower than readState.Index' (duration: 86.255496ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:12:06.31174Z","caller":"traceutil/trace.go:171","msg":"trace[1963262153] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1912; }","duration":"489.54469ms","start":"2026-10-16T00:12:05.822181Z","end":"2026-10-16T00:12:06.311726Z","steps":["trace[1963262153] 'range keys from in-memory index tree' (duration: 489.270174ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:12:06.311785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:12:05.822152Z","time spent":"489.625852ms","remote":"127.0.0.1:39558","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":"info","ts":"2026-10-16T00:12:06.311781Z","caller":"traceutil/trace.go:171","msg":"trace[339574388] transaction","detail":"{read_only:false; response_revision:1913; number_of_response:1; }","duration":"333.235686ms","start":"2026-10-16T00:12:05.978524Z","end":"2026-10-16T00:12:06.311759Z","steps":["trace[339574388] 'process raft request' (duration: 246.900347ms)","trace[339574388] 'compare' (duration: 86.028112ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:12:06.31194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.291859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6183a20c-afdd-4372-b389-5b3a55dbe227\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-10-16T00:12:06.311967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:12:05.97849Z","time spent":"333.385899ms","remote":"127.0.0.1:39558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:12:06.311997Z","caller":"traceutil/trace.go:171","msg":"trace[799674913] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6183a20c-afdd-4372-b389-5b3a55dbe227; range_end:; response_count:1; response_revision:1913; }","duration":"315.3467ms","start":"2026-10-16T00:12:05.996632Z","end":"2026-10-16T00:12:06.311978Z","steps":["trace[799674913] 'agreement among raft nodes before linearized reading' (duration: 315.201557ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:12:06.312039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:12:05.996586Z","time spent":"315.442023ms","remote":"127.0.0.1:39486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3651,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6183a20c-afdd-4372-b389-5b3a55dbe227\" "} {"level":"warn","ts":"2026-10-16T00:12:06.370456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.110128ms","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-16T00:12:06.370587Z","caller":"traceutil/trace.go:171","msg":"trace[1998860153] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1914; }","duration":"193.257011ms","start":"2026-10-16T00:12:06.1773Z","end":"2026-10-16T00:12:06.370557Z","steps":["trace[1998860153] 'agreement among raft nodes before linearized reading' (duration: 192.927024ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:12:06.370654Z","caller":"traceutil/trace.go:171","msg":"trace[166708817] transaction","detail":"{read_only:false; response_revision:1914; number_of_response:1; }","duration":"333.233176ms","start":"2026-10-16T00:12:06.037394Z","end":"2026-10-16T00:12:06.370627Z","steps":["trace[166708817] 'process raft request' (duration: 332.570011ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:12:06.370794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.974301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-16T00:12:06.37085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:12:06.03736Z","time spent":"333.351707ms","remote":"127.0.0.1:39558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:12:06.370893Z","caller":"traceutil/trace.go:171","msg":"trace[157225950] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1914; }","duration":"186.113723ms","start":"2026-10-16T00:12:06.184761Z","end":"2026-10-16T00:12:06.370875Z","steps":["trace[157225950] 'agreement among raft nodes before linearized reading' (duration: 185.952769ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:12:06.569888Z","caller":"traceutil/trace.go:171","msg":"trace[354740196] transaction","detail":"{read_only:false; response_revision:1916; number_of_response:1; }","duration":"252.300906ms","start":"2026-10-16T00:12:06.317552Z","end":"2026-10-16T00:12:06.569853Z","steps":["trace[354740196] 'process raft request' (duration: 252.222954ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:12:06.570223Z","caller":"traceutil/trace.go:171","msg":"trace[591227684] transaction","detail":"{read_only:false; response_revision:1915; number_of_response:1; }","duration":"253.206607ms","start":"2026-10-16T00:12:06.316906Z","end":"2026-10-16T00:12:06.570112Z","steps":["trace[591227684] 'process raft request' (duration: 252.671625ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:12:06.875436Z","caller":"traceutil/trace.go:171","msg":"trace[1761455731] transaction","detail":"{read_only:false; response_revision:1917; number_of_response:1; }","duration":"499.861568ms","start":"2026-10-16T00:12:06.375531Z","end":"2026-10-16T00:12:06.875393Z","steps":["trace[1761455731] 'process raft request' (duration: 483.592059ms)","trace[1761455731] 'compare' (duration: 15.931362ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:12:06.875589Z","caller":"traceutil/trace.go:171","msg":"trace[457567893] transaction","detail":"{read_only:false; response_revision:1918; number_of_response:1; }","duration":"496.514004ms","start":"2026-10-16T00:12:06.379053Z","end":"2026-10-16T00:12:06.875567Z","steps":["trace[457567893] 'process raft request' (duration: 496.288909ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:12:06.875637Z","caller":"traceutil/trace.go:171","msg":"trace[1762591020] transaction","detail":"{read_only:false; response_revision:1919; number_of_response:1; }","duration":"304.376008ms","start":"2026-10-16T00:12:06.571229Z","end":"2026-10-16T00:12:06.875605Z","steps":["trace[1762591020] 'process raft request' (duration: 304.255855ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:12:06.875681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:12:06.375496Z","time spent":"500.077503ms","remote":"127.0.0.1:39558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T00:12:06.875706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:12:06.379028Z","time spent":"496.608907ms","remote":"127.0.0.1:39486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3729,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T00:12:06.875854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:12:06.571193Z","time spent":"304.518601ms","remote":"127.0.0.1:39316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:12:06.875845Z","caller":"traceutil/trace.go:171","msg":"trace[239589363] transaction","detail":"{read_only:false; response_revision:1920; number_of_response:1; }","duration":"143.364139ms","start":"2026-10-16T00:12:06.732433Z","end":"2026-10-16T00:12:06.875797Z","steps":["trace[239589363] 'process raft request' (duration: 143.116894ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:12:22.694404Z","caller":"traceutil/trace.go:171","msg":"trace[1805935107] linearizableReadLoop","detail":"{readStateIndex:2129; appliedIndex:2128; }","duration":"188.918255ms","start":"2026-10-16T00:12:22.505459Z","end":"2026-10-16T00:12:22.694377Z","steps":["trace[1805935107] 'read index received' (duration: 188.750711ms)","trace[1805935107] 'applied index is now lower than readState.Index' (duration: 166.034µs)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:12:22.694522Z","caller":"traceutil/trace.go:171","msg":"trace[430235775] transaction","detail":"{read_only:false; response_revision:2054; number_of_response:1; }","duration":"262.014289ms","start":"2026-10-16T00:12:22.43248Z","end":"2026-10-16T00:12:22.694495Z","steps":["trace[430235775] 'process raft request' (duration: 261.735102ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:12:22.694704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.231922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-10-16T00:12:22.694762Z","caller":"traceutil/trace.go:171","msg":"trace[1270750656] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2054; }","duration":"189.320544ms","start":"2026-10-16T00:12:22.505423Z","end":"2026-10-16T00:12:22.694743Z","steps":["trace[1270750656] 'agreement among raft nodes before linearized reading' (duration: 189.15341ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:12:50.925514Z","caller":"traceutil/trace.go:171","msg":"trace[1787978690] linearizableReadLoop","detail":"{readStateIndex:2295; appliedIndex:2294; }","duration":"443.203771ms","start":"2026-10-16T00:12:50.48229Z","end":"2026-10-16T00:12:50.925493Z","steps":["trace[1787978690] 'read index received' (duration: 443.056618ms)","trace[1787978690] 'applied index is now lower than readState.Index' (duration: 145.993µs)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:12:50.925573Z","caller":"traceutil/trace.go:171","msg":"trace[372900990] transaction","detail":"{read_only:false; response_revision:2214; number_of_response:1; }","duration":"454.152624ms","start":"2026-10-16T00:12:50.4714Z","end":"2026-10-16T00:12:50.925553Z","steps":["trace[372900990] 'process raft request' (duration: 453.919089ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:12:50.925652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.359465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:12:50.925691Z","caller":"traceutil/trace.go:171","msg":"trace[954781903] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2214; }","duration":"443.450727ms","start":"2026-10-16T00:12:50.48223Z","end":"2026-10-16T00:12:50.92568Z","steps":["trace[954781903] 'agreement among raft nodes before linearized reading' (duration: 443.363685ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:12:50.925699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:12:50.471378Z","time spent":"454.250167ms","remote":"127.0.0.1:39558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T00:12:50.925791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:12:50.482218Z","time spent":"443.551809ms","remote":"127.0.0.1:52062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-10-16T00:12:50.959734Z","caller":"traceutil/trace.go:171","msg":"trace[1367849972] transaction","detail":"{read_only:false; response_revision:2215; number_of_response:1; }","duration":"166.838154ms","start":"2026-10-16T00:12:50.792849Z","end":"2026-10-16T00:12:50.959687Z","steps":["trace[1367849972] 'process raft request' (duration: 166.610199ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:12:51.145956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.377049ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-10-16T00:12:51.146152Z","caller":"traceutil/trace.go:171","msg":"trace[1173814877] linearizableReadLoop","detail":"{readStateIndex:2297; appliedIndex:2295; }","duration":"220.546928ms","start":"2026-10-16T00:12:50.925576Z","end":"2026-10-16T00:12:51.146122Z","steps":["trace[1173814877] 'read index received' (duration: 33.853462ms)","trace[1173814877] 'applied index is now lower than readState.Index' (duration: 186.690675ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:12:51.146328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"635.494231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-16T00:12:51.14634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.802866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-10-16T00:12:51.146397Z","caller":"traceutil/trace.go:171","msg":"trace[1830195423] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:2215; }","duration":"635.579403ms","start":"2026-10-16T00:12:50.510795Z","end":"2026-10-16T00:12:51.146374Z","steps":["trace[1830195423] 'agreement among raft nodes before linearized reading' (duration: 635.45532ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:12:51.146401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.525795ms","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-16T00:12:51.146422Z","caller":"traceutil/trace.go:171","msg":"trace[1738211522] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2215; }","duration":"244.890158ms","start":"2026-10-16T00:12:50.901508Z","end":"2026-10-16T00:12:51.146398Z","steps":["trace[1738211522] 'agreement among raft nodes before linearized reading' (duration: 244.641192ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:12:51.146453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:12:50.510765Z","time spent":"635.671256ms","remote":"127.0.0.1:35156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "} {"level":"info","ts":"2026-10-16T00:12:51.146486Z","caller":"traceutil/trace.go:171","msg":"trace[1838546598] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2215; }","duration":"305.690768ms","start":"2026-10-16T00:12:50.840776Z","end":"2026-10-16T00:12:51.146467Z","steps":["trace[1838546598] 'agreement among raft nodes before linearized reading' (duration: 305.422542ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:12:51.146546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:12:50.840748Z","time spent":"305.785141ms","remote":"127.0.0.1:39558","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-16T00:12:51.146378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.422031ms","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-16T00:12:51.146619Z","caller":"traceutil/trace.go:171","msg":"trace[1687627884] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2215; }","duration":"282.714368ms","start":"2026-10-16T00:12:50.863879Z","end":"2026-10-16T00:12:51.146593Z","steps":["trace[1687627884] 'agreement among raft nodes before linearized reading' (duration: 282.284768ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:12:51.158425Z","caller":"traceutil/trace.go:171","msg":"trace[204585167] transaction","detail":"{read_only:false; response_revision:2216; number_of_response:1; }","duration":"101.414803ms","start":"2026-10-16T00:12:51.056971Z","end":"2026-10-16T00:12:51.158386Z","steps":["trace[204585167] 'process raft request' (duration: 101.222499ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:12:51.158591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.481923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:12:51.158696Z","caller":"traceutil/trace.go:171","msg":"trace[1200881363] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2216; }","duration":"101.634237ms","start":"2026-10-16T00:12:51.057039Z","end":"2026-10-16T00:12:51.158673Z","steps":["trace[1200881363] 'agreement among raft nodes before linearized reading' (duration: 101.415642ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:12:51.355289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.044318ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-16T00:12:51.355431Z","caller":"traceutil/trace.go:171","msg":"trace[716008680] transaction","detail":"{read_only:false; response_revision:2219; number_of_response:1; }","duration":"138.987637ms","start":"2026-10-16T00:12:51.216419Z","end":"2026-10-16T00:12:51.355406Z","steps":["trace[716008680] 'process raft request' (duration: 35.721714ms)","trace[716008680] 'compare' (duration: 102.880494ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:12:57.576809Z","caller":"traceutil/trace.go:171","msg":"trace[1497220049] transaction","detail":"{read_only:false; response_revision:2249; number_of_response:1; }","duration":"268.817659ms","start":"2026-10-16T00:12:57.307943Z","end":"2026-10-16T00:12:57.576761Z","steps":["trace[1497220049] 'process raft request' (duration: 268.619024ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:12:57.647187Z","caller":"traceutil/trace.go:171","msg":"trace[440965659] transaction","detail":"{read_only:false; response_revision:2250; number_of_response:1; }","duration":"339.151301ms","start":"2026-10-16T00:12:57.308009Z","end":"2026-10-16T00:12:57.64716Z","steps":["trace[440965659] 'process raft request' (duration: 302.900266ms)","trace[440965659] 'compare' (duration: 36.073521ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:12:57.647318Z","caller":"traceutil/trace.go:171","msg":"trace[155369039] linearizableReadLoop","detail":"{readStateIndex:2333; appliedIndex:2331; }","duration":"269.352371ms","start":"2026-10-16T00:12:57.377933Z","end":"2026-10-16T00:12:57.647285Z","steps":["trace[155369039] 'read index received' (duration: 198.62828ms)","trace[155369039] 'applied index is now lower than readState.Index' (duration: 70.722171ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:12:57.647357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:12:57.307979Z","time spent":"339.281864ms","remote":"127.0.0.1:39558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:12:57.647468Z","caller":"traceutil/trace.go:171","msg":"trace[1224129417] transaction","detail":"{read_only:false; response_revision:2251; number_of_response:1; }","duration":"147.795591ms","start":"2026-10-16T00:12:57.499566Z","end":"2026-10-16T00:12:57.647361Z","steps":["trace[1224129417] 'process raft request' (duration: 147.545096ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:12:57.647536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.581366ms","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-16T00:12:57.647572Z","caller":"traceutil/trace.go:171","msg":"trace[1601036671] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2251; }","duration":"269.661478ms","start":"2026-10-16T00:12:57.377898Z","end":"2026-10-16T00:12:57.64756Z","steps":["trace[1601036671] 'agreement among raft nodes before linearized reading' (duration: 269.487704ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:13:03.234226Z","caller":"traceutil/trace.go:171","msg":"trace[1995536016] transaction","detail":"{read_only:false; response_revision:2276; number_of_response:1; }","duration":"224.27769ms","start":"2026-10-16T00:13:03.00991Z","end":"2026-10-16T00:13:03.234187Z","steps":["trace[1995536016] 'process raft request' (duration: 224.089686ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:13:03.658279Z","caller":"traceutil/trace.go:171","msg":"trace[77838733] linearizableReadLoop","detail":"{readStateIndex:2361; appliedIndex:2359; }","duration":"601.929676ms","start":"2026-10-16T00:13:03.056331Z","end":"2026-10-16T00:13:03.65826Z","steps":["trace[77838733] 'read index received' (duration: 177.688975ms)","trace[77838733] 'applied index is now lower than readState.Index' (duration: 424.240061ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:13:03.658385Z","caller":"traceutil/trace.go:171","msg":"trace[123552115] transaction","detail":"{read_only:false; response_revision:2277; number_of_response:1; }","duration":"642.375693ms","start":"2026-10-16T00:13:03.016002Z","end":"2026-10-16T00:13:03.658377Z","steps":["trace[123552115] 'process raft request' (duration: 642.090557ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:13:03.65848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:13:03.015984Z","time spent":"642.417755ms","remote":"127.0.0.1:39558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:13:03.658736Z","caller":"traceutil/trace.go:171","msg":"trace[386097137] transaction","detail":"{read_only:false; response_revision:2278; number_of_response:1; }","duration":"439.267944ms","start":"2026-10-16T00:13:03.219458Z","end":"2026-10-16T00:13:03.658726Z","steps":["trace[386097137] 'process raft request' (duration: 438.770783ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:13:03.658776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:13:03.219418Z","time spent":"439.338476ms","remote":"127.0.0.1:39558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T00:13:03.659028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.660313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-16T00:13:03.659128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.391251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-10-16T00:13:03.659163Z","caller":"traceutil/trace.go:171","msg":"trace[1491784683] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2278; }","duration":"602.868087ms","start":"2026-10-16T00:13:03.056258Z","end":"2026-10-16T00:13:03.659126Z","steps":["trace[1491784683] 'agreement among raft nodes before linearized reading' (duration: 602.634592ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:13:03.659197Z","caller":"traceutil/trace.go:171","msg":"trace[1796223191] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2278; }","duration":"418.502683ms","start":"2026-10-16T00:13:03.240675Z","end":"2026-10-16T00:13:03.659178Z","steps":["trace[1796223191] 'agreement among raft nodes before linearized reading' (duration: 418.255938ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:13:03.659227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:13:03.05623Z","time spent":"602.983169ms","remote":"127.0.0.1:39288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-16T00:13:03.659243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:13:03.240653Z","time spent":"418.577574ms","remote":"127.0.0.1:53232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-10-16T00:13:03.854621Z","caller":"traceutil/trace.go:171","msg":"trace[159831867] transaction","detail":"{read_only:false; response_revision:2279; number_of_response:1; }","duration":"190.217014ms","start":"2026-10-16T00:13:03.66436Z","end":"2026-10-16T00:13:03.854577Z","steps":["trace[159831867] 'process raft request' (duration: 105.726158ms)","trace[159831867] 'compare' (duration: 84.192539ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:13:03.854657Z","caller":"traceutil/trace.go:171","msg":"trace[438555981] linearizableReadLoop","detail":"{readStateIndex:2363; appliedIndex:2362; }","duration":"188.496075ms","start":"2026-10-16T00:13:03.666089Z","end":"2026-10-16T00:13:03.854585Z","steps":["trace[438555981] 'read index received' (duration: 103.999179ms)","trace[438555981] 'applied index is now lower than readState.Index' (duration: 84.495266ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:13:03.854803Z","caller":"traceutil/trace.go:171","msg":"trace[1151921816] transaction","detail":"{read_only:false; response_revision:2280; number_of_response:1; }","duration":"184.64983ms","start":"2026-10-16T00:13:03.670125Z","end":"2026-10-16T00:13:03.854775Z","steps":["trace[1151921816] 'process raft request' (duration: 184.410675ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:13:03.855028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.844176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-16T00:13:03.855085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.10259ms","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":"warn","ts":"2026-10-16T00:13:03.855089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.368863ms","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-16T00:13:03.855311Z","caller":"traceutil/trace.go:171","msg":"trace[181551052] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2280; }","duration":"170.623829ms","start":"2026-10-16T00:13:03.684674Z","end":"2026-10-16T00:13:03.855298Z","steps":["trace[181551052] 'agreement among raft nodes before linearized reading' (duration: 170.322232ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:13:03.855108Z","caller":"traceutil/trace.go:171","msg":"trace[2032879441] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:2280; }","duration":"112.991959ms","start":"2026-10-16T00:13:03.742095Z","end":"2026-10-16T00:13:03.855087Z","steps":["trace[2032879441] 'agreement among raft nodes before linearized reading' (duration: 112.852776ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:13:03.855196Z","caller":"traceutil/trace.go:171","msg":"trace[1423555338] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2280; }","duration":"135.266673ms","start":"2026-10-16T00:13:03.719912Z","end":"2026-10-16T00:13:03.855179Z","steps":["trace[1423555338] 'agreement among raft nodes before linearized reading' (duration: 134.963907ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:13:03.855124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.475548ms","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-16T00:13:03.85542Z","caller":"traceutil/trace.go:171","msg":"trace[944572866] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2280; }","duration":"180.843386ms","start":"2026-10-16T00:13:03.674567Z","end":"2026-10-16T00:13:03.855411Z","steps":["trace[944572866] 'agreement among raft nodes before linearized reading' (duration: 180.295623ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:13:03.855429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.453827ms","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-16T00:13:03.855509Z","caller":"traceutil/trace.go:171","msg":"trace[318671315] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2280; }","duration":"171.57454ms","start":"2026-10-16T00:13:03.68391Z","end":"2026-10-16T00:13:03.855484Z","steps":["trace[318671315] 'agreement among raft nodes before linearized reading' (duration: 171.213372ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:13:03.855761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.232462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-16T00:13:03.856038Z","caller":"traceutil/trace.go:171","msg":"trace[1737102603] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:2280; }","duration":"189.998539ms","start":"2026-10-16T00:13:03.666025Z","end":"2026-10-16T00:13:03.856024Z","steps":["trace[1737102603] 'agreement among raft nodes before linearized reading' (duration: 188.738981ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:14:26.63453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.970977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-16T00:14:26.634632Z","caller":"traceutil/trace.go:171","msg":"trace[1001932742] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:2890; }","duration":"173.141731ms","start":"2026-10-16T00:14:26.461471Z","end":"2026-10-16T00:14:26.634612Z","steps":["trace[1001932742] 'count revisions from in-memory index tree' (duration: 172.859055ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:15:00.212641Z","caller":"traceutil/trace.go:171","msg":"trace[103193762] transaction","detail":"{read_only:false; response_revision:3090; number_of_response:1; }","duration":"107.54902ms","start":"2026-10-16T00:15:00.10507Z","end":"2026-10-16T00:15:00.212619Z","steps":["trace[103193762] 'process raft request' (duration: 107.457868ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:15:05.406926Z","caller":"traceutil/trace.go:171","msg":"trace[1207293790] linearizableReadLoop","detail":"{readStateIndex:3236; appliedIndex:3235; }","duration":"122.356358ms","start":"2026-10-16T00:15:05.284541Z","end":"2026-10-16T00:15:05.406898Z","steps":["trace[1207293790] 'read index received' (duration: 122.163553ms)","trace[1207293790] 'applied index is now lower than readState.Index' (duration: 191.505µs)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:15:05.40698Z","caller":"traceutil/trace.go:171","msg":"trace[1326068964] transaction","detail":"{read_only:false; response_revision:3121; number_of_response:1; }","duration":"122.579472ms","start":"2026-10-16T00:15:05.284367Z","end":"2026-10-16T00:15:05.406946Z","steps":["trace[1326068964] 'process raft request' (duration: 122.343077ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:15:05.407106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.542521ms","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-16T00:15:05.407221Z","caller":"traceutil/trace.go:171","msg":"trace[1190667676] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:3121; }","duration":"122.649404ms","start":"2026-10-16T00:15:05.28448Z","end":"2026-10-16T00:15:05.407129Z","steps":["trace[1190667676] 'agreement among raft nodes before linearized reading' (duration: 122.556582ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:18:23.643376Z","caller":"traceutil/trace.go:171","msg":"trace[1312920412] transaction","detail":"{read_only:false; response_revision:4362; number_of_response:1; }","duration":"112.4036ms","start":"2026-10-16T00:18:23.530909Z","end":"2026-10-16T00:18:23.643313Z","steps":["trace[1312920412] 'process raft request' (duration: 112.108663ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:18:23.914715Z","caller":"traceutil/trace.go:171","msg":"trace[1903758755] linearizableReadLoop","detail":"{readStateIndex:4528; appliedIndex:4524; }","duration":"204.40469ms","start":"2026-10-16T00:18:23.710281Z","end":"2026-10-16T00:18:23.914686Z","steps":["trace[1903758755] 'read index received' (duration: 151.009482ms)","trace[1903758755] 'applied index is now lower than readState.Index' (duration: 53.393568ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:18:23.914911Z","caller":"traceutil/trace.go:171","msg":"trace[1807785076] transaction","detail":"{read_only:false; response_revision:4365; number_of_response:1; }","duration":"266.420618ms","start":"2026-10-16T00:18:23.648478Z","end":"2026-10-16T00:18:23.914898Z","steps":["trace[1807785076] 'process raft request' (duration: 266.144362ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:18:23.914953Z","caller":"traceutil/trace.go:171","msg":"trace[647248209] transaction","detail":"{read_only:false; response_revision:4363; number_of_response:1; }","duration":"266.700934ms","start":"2026-10-16T00:18:23.648236Z","end":"2026-10-16T00:18:23.914937Z","steps":["trace[647248209] 'process raft request' (duration: 212.957828ms)","trace[647248209] 'compare' (duration: 53.196094ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:18:23.91489Z","caller":"traceutil/trace.go:171","msg":"trace[2131590409] transaction","detail":"{read_only:false; response_revision:4364; number_of_response:1; }","duration":"266.400377ms","start":"2026-10-16T00:18:23.648417Z","end":"2026-10-16T00:18:23.914818Z","steps":["trace[2131590409] 'process raft request' (duration: 266.156212ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:18:23.915028Z","caller":"traceutil/trace.go:171","msg":"trace[1927573598] transaction","detail":"{read_only:false; response_revision:4366; number_of_response:1; }","duration":"266.51841ms","start":"2026-10-16T00:18:23.648469Z","end":"2026-10-16T00:18:23.914987Z","steps":["trace[1927573598] 'process raft request' (duration: 266.183933ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:18:23.915245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.90128ms","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-16T00:18:23.915409Z","caller":"traceutil/trace.go:171","msg":"trace[1830779913] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4366; }","duration":"205.162487ms","start":"2026-10-16T00:18:23.710213Z","end":"2026-10-16T00:18:23.915375Z","steps":["trace[1830779913] 'agreement among raft nodes before linearized reading' (duration: 204.808229ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:19:32.32196Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2925} {"level":"info","ts":"2026-10-16T00:19:32.408291Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2925,"took":"85.184019ms","hash":2392894579,"current-db-size-bytes":44388352,"current-db-size":"44 MB","current-db-size-in-use-bytes":20279296,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-10-16T00:19:32.408366Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2392894579,"revision":2925,"compact-revision":-1} {"level":"info","ts":"2026-10-16T00:19:49.123386Z","caller":"traceutil/trace.go:171","msg":"trace[523551449] transaction","detail":"{read_only:false; response_revision:5422; number_of_response:1; }","duration":"109.985147ms","start":"2026-10-16T00:19:49.013363Z","end":"2026-10-16T00:19:49.123348Z","steps":["trace[523551449] 'process raft request' (duration: 109.545837ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:19:54.27754Z","caller":"traceutil/trace.go:171","msg":"trace[1748976834] linearizableReadLoop","detail":"{readStateIndex:5767; appliedIndex:5766; }","duration":"101.820586ms","start":"2026-10-16T00:19:54.175689Z","end":"2026-10-16T00:19:54.27751Z","steps":["trace[1748976834] 'read index received' (duration: 101.593661ms)","trace[1748976834] 'applied index is now lower than readState.Index' (duration: 225.925µs)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:19:54.277641Z","caller":"traceutil/trace.go:171","msg":"trace[280617720] transaction","detail":"{read_only:false; response_revision:5558; number_of_response:1; }","duration":"131.342278ms","start":"2026-10-16T00:19:54.146241Z","end":"2026-10-16T00:19:54.277583Z","steps":["trace[280617720] 'process raft request' (duration: 131.103152ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:19:54.277765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.039161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:19:54.277939Z","caller":"traceutil/trace.go:171","msg":"trace[647933827] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:0; response_revision:5558; }","duration":"102.270147ms","start":"2026-10-16T00:19:54.175641Z","end":"2026-10-16T00:19:54.277911Z","steps":["trace[647933827] 'agreement among raft nodes before linearized reading' (duration: 101.98263ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:19:54.544448Z","caller":"traceutil/trace.go:171","msg":"trace[1496432501] linearizableReadLoop","detail":"{readStateIndex:5769; appliedIndex:5768; }","duration":"156.494901ms","start":"2026-10-16T00:19:54.387924Z","end":"2026-10-16T00:19:54.544419Z","steps":["trace[1496432501] 'read index received' (duration: 156.208995ms)","trace[1496432501] 'applied index is now lower than readState.Index' (duration: 285.006µs)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:19:54.544578Z","caller":"traceutil/trace.go:171","msg":"trace[500832265] transaction","detail":"{read_only:false; response_revision:5559; number_of_response:1; }","duration":"163.812073ms","start":"2026-10-16T00:19:54.380754Z","end":"2026-10-16T00:19:54.544566Z","steps":["trace[500832265] 'process raft request' (duration: 163.491776ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:19:54.544962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.029494ms","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-16T00:19:54.545038Z","caller":"traceutil/trace.go:171","msg":"trace[1018395116] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5559; }","duration":"157.176007ms","start":"2026-10-16T00:19:54.387851Z","end":"2026-10-16T00:19:54.545027Z","steps":["trace[1018395116] 'agreement among raft nodes before linearized reading' (duration: 156.88479ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:19:54.545144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.385298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-10-16T00:19:54.545147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.650141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-98rn8\" ","response":"range_response_count:1 size:6530"} {"level":"warn","ts":"2026-10-16T00:19:54.545354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.284829ms","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-16T00:19:54.545501Z","caller":"traceutil/trace.go:171","msg":"trace[2021943225] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5559; }","duration":"147.487123ms","start":"2026-10-16T00:19:54.397983Z","end":"2026-10-16T00:19:54.54547Z","steps":["trace[2021943225] 'agreement among raft nodes before linearized reading' (duration: 146.681985ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:19:54.545388Z","caller":"traceutil/trace.go:171","msg":"trace[1677805427] range","detail":"{range_begin:/registry/pods/openstack/keepalived-98rn8; range_end:; response_count:1; response_revision:5559; }","duration":"130.07192ms","start":"2026-10-16T00:19:54.415291Z","end":"2026-10-16T00:19:54.545363Z","steps":["trace[1677805427] 'agreement among raft nodes before linearized reading' (duration: 129.425926ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:19:54.545515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.940441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-10-16T00:19:54.545759Z","caller":"traceutil/trace.go:171","msg":"trace[1200898342] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5559; }","duration":"147.227427ms","start":"2026-10-16T00:19:54.398504Z","end":"2026-10-16T00:19:54.545732Z","steps":["trace[1200898342] 'agreement among raft nodes before linearized reading' (duration: 146.737547ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:19:54.54526Z","caller":"traceutil/trace.go:171","msg":"trace[2137874061] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5559; }","duration":"146.543402ms","start":"2026-10-16T00:19:54.398691Z","end":"2026-10-16T00:19:54.545235Z","steps":["trace[2137874061] 'agreement among raft nodes before linearized reading' (duration: 146.126643ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:19:54.968206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.899546ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-16T00:19:54.96833Z","caller":"traceutil/trace.go:171","msg":"trace[185878269] transaction","detail":"{read_only:false; response_revision:5569; number_of_response:1; }","duration":"262.90247ms","start":"2026-10-16T00:19:54.705404Z","end":"2026-10-16T00:19:54.968307Z","steps":["trace[185878269] 'process raft request' (duration: 146.806669ms)","trace[185878269] 'compare' (duration: 115.697172ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:19:55.016684Z","caller":"traceutil/trace.go:171","msg":"trace[1645267506] linearizableReadLoop","detail":"{readStateIndex:5780; appliedIndex:5778; }","duration":"310.352876ms","start":"2026-10-16T00:19:54.706309Z","end":"2026-10-16T00:19:55.016662Z","steps":["trace[1645267506] 'read index received' (duration: 146.010421ms)","trace[1645267506] 'applied index is now lower than readState.Index' (duration: 164.340905ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:19:55.016893Z","caller":"traceutil/trace.go:171","msg":"trace[1686598906] transaction","detail":"{read_only:false; response_revision:5571; number_of_response:1; }","duration":"310.376558ms","start":"2026-10-16T00:19:54.706437Z","end":"2026-10-16T00:19:55.016814Z","steps":["trace[1686598906] 'process raft request' (duration: 310.159733ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:19:55.016928Z","caller":"traceutil/trace.go:171","msg":"trace[168786791] transaction","detail":"{read_only:false; response_revision:5570; number_of_response:1; }","duration":"310.625023ms","start":"2026-10-16T00:19:54.706233Z","end":"2026-10-16T00:19:55.016858Z","steps":["trace[168786791] 'process raft request' (duration: 310.208113ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:19:55.017026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.655023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:17254"} {"level":"info","ts":"2026-10-16T00:19:55.017109Z","caller":"traceutil/trace.go:171","msg":"trace[1752038155] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:5571; }","duration":"310.799456ms","start":"2026-10-16T00:19:54.706277Z","end":"2026-10-16T00:19:55.017077Z","steps":["trace[1752038155] 'agreement among raft nodes before linearized reading' (duration: 310.48925ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:19:55.017147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:19:54.706264Z","time spent":"310.871938ms","remote":"127.0.0.1:39480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":17278,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-10-16T00:19:55.017181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:19:54.706426Z","time spent":"310.644933ms","remote":"127.0.0.1:39748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4833,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-16T00:19:55.017193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:19:54.706208Z","time spent":"310.889169ms","remote":"127.0.0.1:39468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":926,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-16T00:19:55.03156Z","caller":"traceutil/trace.go:171","msg":"trace[771497187] transaction","detail":"{read_only:false; response_revision:5572; number_of_response:1; }","duration":"124.357734ms","start":"2026-10-16T00:19:54.907176Z","end":"2026-10-16T00:19:55.031533Z","steps":["trace[771497187] 'process raft request' (duration: 124.1989ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:19:55.032079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.067863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a200a903-b6bd-403a-98d7-39660b91965f\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-10-16T00:19:55.032121Z","caller":"traceutil/trace.go:171","msg":"trace[1942166801] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a200a903-b6bd-403a-98d7-39660b91965f; range_end:; response_count:1; response_revision:5572; }","duration":"214.195155ms","start":"2026-10-16T00:19:54.817915Z","end":"2026-10-16T00:19:55.03211Z","steps":["trace[1942166801] 'agreement among raft nodes before linearized reading' (duration: 214.019942ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:19:55.03224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.531116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a200a903-b6bd-403a-98d7-39660b91965f\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-10-16T00:19:55.03238Z","caller":"traceutil/trace.go:171","msg":"trace[1717230536] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a200a903-b6bd-403a-98d7-39660b91965f; range_end:; response_count:1; response_revision:5572; }","duration":"293.708049ms","start":"2026-10-16T00:19:54.738629Z","end":"2026-10-16T00:19:55.032337Z","steps":["trace[1717230536] 'agreement among raft nodes before linearized reading' (duration: 293.238099ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:20:07.199736Z","caller":"traceutil/trace.go:171","msg":"trace[1484818019] transaction","detail":"{read_only:false; response_revision:5788; number_of_response:1; }","duration":"106.627612ms","start":"2026-10-16T00:20:07.09308Z","end":"2026-10-16T00:20:07.199707Z","steps":["trace[1484818019] 'process raft request' (duration: 106.491099ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:20:10.302942Z","caller":"traceutil/trace.go:171","msg":"trace[1848479513] transaction","detail":"{read_only:false; response_revision:5845; number_of_response:1; }","duration":"350.014332ms","start":"2026-10-16T00:20:09.952902Z","end":"2026-10-16T00:20:10.302916Z","steps":["trace[1848479513] 'process raft request' (duration: 349.838768ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:20:10.303099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:20:09.952862Z","time spent":"350.157715ms","remote":"127.0.0.1:39570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1067,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:20:10.829553Z","caller":"traceutil/trace.go:171","msg":"trace[1213610944] transaction","detail":"{read_only:false; response_revision:5846; number_of_response:1; }","duration":"876.578008ms","start":"2026-10-16T00:20:09.952938Z","end":"2026-10-16T00:20:10.829517Z","steps":["trace[1213610944] 'process raft request' (duration: 876.256481ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:20:10.82997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:20:09.952895Z","time spent":"876.772673ms","remote":"127.0.0.1:39468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":681,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:20:10.830013Z","caller":"traceutil/trace.go:171","msg":"trace[1103093518] transaction","detail":"{read_only:false; response_revision:5847; number_of_response:1; }","duration":"876.925116ms","start":"2026-10-16T00:20:09.953042Z","end":"2026-10-16T00:20:10.829967Z","steps":["trace[1103093518] 'process raft request' (duration: 876.400145ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:20:10.830108Z","caller":"traceutil/trace.go:171","msg":"trace[1973775858] linearizableReadLoop","detail":"{readStateIndex:6066; appliedIndex:6063; }","duration":"813.828215ms","start":"2026-10-16T00:20:10.016201Z","end":"2026-10-16T00:20:10.830029Z","steps":["trace[1973775858] 'read index received' (duration: 286.780727ms)","trace[1973775858] 'applied index is now lower than readState.Index' (duration: 527.046088ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:20:10.830314Z","caller":"traceutil/trace.go:171","msg":"trace[1586481001] transaction","detail":"{read_only:false; response_revision:5848; number_of_response:1; }","duration":"877.272993ms","start":"2026-10-16T00:20:09.953025Z","end":"2026-10-16T00:20:10.830298Z","steps":["trace[1586481001] 'process raft request' (duration: 876.799413ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:20:10.830375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:20:09.953009Z","time spent":"877.170642ms","remote":"127.0.0.1:39468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":529,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T00:20:10.830485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"814.266824ms","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-16T00:20:10.830558Z","caller":"traceutil/trace.go:171","msg":"trace[1440649593] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:5848; }","duration":"814.390197ms","start":"2026-10-16T00:20:10.016149Z","end":"2026-10-16T00:20:10.830539Z","steps":["trace[1440649593] 'agreement among raft nodes before linearized reading' (duration: 814.215143ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:20:10.830614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:20:10.016126Z","time spent":"814.469828ms","remote":"127.0.0.1:39496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":48,"response size":31,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"warn","ts":"2026-10-16T00:20:10.830624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:20:09.952954Z","time spent":"877.426217ms","remote":"127.0.0.1:39570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1038,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T00:20:10.846994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"791.212535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:20:10.847073Z","caller":"traceutil/trace.go:171","msg":"trace[144188502] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5849; }","duration":"791.353908ms","start":"2026-10-16T00:20:10.055698Z","end":"2026-10-16T00:20:10.847052Z","steps":["trace[144188502] 'agreement among raft nodes before linearized reading' (duration: 791.218035ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:20:10.847111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:20:10.055665Z","time spent":"791.43562ms","remote":"127.0.0.1:39278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-16T00:20:10.84719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.827049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-98rn8\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-10-16T00:20:10.847282Z","caller":"traceutil/trace.go:171","msg":"trace[1543311829] range","detail":"{range_begin:/registry/pods/openstack/keepalived-98rn8; range_end:; response_count:1; response_revision:5849; }","duration":"151.976492ms","start":"2026-10-16T00:20:10.695277Z","end":"2026-10-16T00:20:10.847253Z","steps":["trace[1543311829] 'agreement among raft nodes before linearized reading' (duration: 151.656255ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:20:10.847651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.309047ms","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-16T00:20:10.847687Z","caller":"traceutil/trace.go:171","msg":"trace[403737612] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5849; }","duration":"160.343458ms","start":"2026-10-16T00:20:10.687332Z","end":"2026-10-16T00:20:10.847675Z","steps":["trace[403737612] 'agreement among raft nodes before linearized reading' (duration: 160.213755ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:20:10.848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.830836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-10-16T00:20:10.848059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.746894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-10-16T00:20:10.848065Z","caller":"traceutil/trace.go:171","msg":"trace[292824911] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5849; }","duration":"149.914287ms","start":"2026-10-16T00:20:10.698134Z","end":"2026-10-16T00:20:10.848048Z","steps":["trace[292824911] 'agreement among raft nodes before linearized reading' (duration: 149.678932ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:20:10.848133Z","caller":"traceutil/trace.go:171","msg":"trace[1726498051] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5849; }","duration":"149.881456ms","start":"2026-10-16T00:20:10.698233Z","end":"2026-10-16T00:20:10.848114Z","steps":["trace[1726498051] 'agreement among raft nodes before linearized reading' (duration: 149.535709ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:20:10.848185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.774484ms","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-16T00:20:10.848226Z","caller":"traceutil/trace.go:171","msg":"trace[80818465] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5849; }","duration":"459.861126ms","start":"2026-10-16T00:20:10.388353Z","end":"2026-10-16T00:20:10.848214Z","steps":["trace[80818465] 'agreement among raft nodes before linearized reading' (duration: 459.753733ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:20:10.848258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:20:10.388323Z","time spent":"459.927786ms","remote":"127.0.0.1:39486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-10-16T00:20:10.848431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"619.64415ms","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-16T00:20:10.848509Z","caller":"traceutil/trace.go:171","msg":"trace[1278140682] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5849; }","duration":"619.795174ms","start":"2026-10-16T00:20:10.228691Z","end":"2026-10-16T00:20:10.848486Z","steps":["trace[1278140682] 'agreement among raft nodes before linearized reading' (duration: 619.64172ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:20:10.848573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:20:10.228664Z","time spent":"619.884235ms","remote":"127.0.0.1:53230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-10-16T00:20:10.848079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.321819ms","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-16T00:20:10.848933Z","caller":"traceutil/trace.go:171","msg":"trace[1025325815] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5849; }","duration":"162.215448ms","start":"2026-10-16T00:20:10.686702Z","end":"2026-10-16T00:20:10.848918Z","steps":["trace[1025325815] 'agreement among raft nodes before linearized reading' (duration: 161.276477ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:20:10.849121Z","caller":"traceutil/trace.go:171","msg":"trace[1915028895] transaction","detail":"{read_only:false; response_revision:5849; number_of_response:1; }","duration":"434.608088ms","start":"2026-10-16T00:20:10.414475Z","end":"2026-10-16T00:20:10.849083Z","steps":["trace[1915028895] 'process raft request' (duration: 432.186994ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:20:10.849128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.576826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-10-16T00:20:10.849179Z","caller":"traceutil/trace.go:171","msg":"trace[887352355] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5849; }","duration":"492.684289ms","start":"2026-10-16T00:20:10.356482Z","end":"2026-10-16T00:20:10.849167Z","steps":["trace[887352355] 'agreement among raft nodes before linearized reading' (duration: 492.329661ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:20:10.84921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:20:10.356451Z","time spent":"492.7514ms","remote":"127.0.0.1:39558","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-16T00:20:10.849234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:20:10.414429Z","time spent":"434.736941ms","remote":"127.0.0.1:39480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19266,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:20:18.298508Z","caller":"traceutil/trace.go:171","msg":"trace[869293755] transaction","detail":"{read_only:false; response_revision:6006; number_of_response:1; }","duration":"188.717273ms","start":"2026-10-16T00:20:18.109756Z","end":"2026-10-16T00:20:18.298473Z","steps":["trace[869293755] 'process raft request' (duration: 188.230712ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:21:11.417626Z","caller":"traceutil/trace.go:171","msg":"trace[709002683] transaction","detail":"{read_only:false; response_revision:6512; number_of_response:1; }","duration":"100.374702ms","start":"2026-10-16T00:21:11.317224Z","end":"2026-10-16T00:21:11.417599Z","steps":["trace[709002683] 'process raft request' (duration: 100.213039ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:24:32.329464Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":4806} {"level":"info","ts":"2026-10-16T00:24:32.39377Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":4806,"took":"62.773004ms","hash":3141235334,"current-db-size-bytes":44388352,"current-db-size":"44 MB","current-db-size-in-use-bytes":39112704,"current-db-size-in-use":"39 MB"} {"level":"info","ts":"2026-10-16T00:24:32.393861Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3141235334,"revision":4806,"compact-revision":2925} {"level":"info","ts":"2026-10-16T00:26:19.025031Z","caller":"traceutil/trace.go:171","msg":"trace[1432006778] transaction","detail":"{read_only:false; response_revision:8659; number_of_response:1; }","duration":"111.318015ms","start":"2026-10-16T00:26:18.913645Z","end":"2026-10-16T00:26:19.024963Z","steps":["trace[1432006778] 'process raft request' (duration: 111.227423ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:26:19.02504Z","caller":"traceutil/trace.go:171","msg":"trace[1460636060] transaction","detail":"{read_only:false; response_revision:8658; number_of_response:1; }","duration":"130.721624ms","start":"2026-10-16T00:26:18.89425Z","end":"2026-10-16T00:26:19.024972Z","steps":["trace[1460636060] 'process raft request' (duration: 130.505259ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:26:19.025235Z","caller":"traceutil/trace.go:171","msg":"trace[1069929131] transaction","detail":"{read_only:false; response_revision:8660; number_of_response:1; }","duration":"109.040745ms","start":"2026-10-16T00:26:18.916166Z","end":"2026-10-16T00:26:19.025207Z","steps":["trace[1069929131] 'process raft request' (duration: 108.763679ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:26:36.072659Z","caller":"traceutil/trace.go:171","msg":"trace[1531976797] linearizableReadLoop","detail":"{readStateIndex:9201; appliedIndex:9200; }","duration":"172.375202ms","start":"2026-10-16T00:26:35.90026Z","end":"2026-10-16T00:26:36.072636Z","steps":["trace[1531976797] 'read index received' (duration: 123.008133ms)","trace[1531976797] 'applied index is now lower than readState.Index' (duration: 49.365889ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:26:36.072791Z","caller":"traceutil/trace.go:171","msg":"trace[126390811] transaction","detail":"{read_only:false; response_revision:8886; number_of_response:1; }","duration":"257.138593ms","start":"2026-10-16T00:26:35.815613Z","end":"2026-10-16T00:26:36.072751Z","steps":["trace[126390811] 'process raft request' (duration: 207.729022ms)","trace[126390811] 'compare' (duration: 49.148575ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:26:36.072946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.668779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:528"} {"level":"info","ts":"2026-10-16T00:26:36.072983Z","caller":"traceutil/trace.go:171","msg":"trace[1244545119] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:8886; }","duration":"172.76394ms","start":"2026-10-16T00:26:35.900208Z","end":"2026-10-16T00:26:36.072971Z","steps":["trace[1244545119] 'agreement among raft nodes before linearized reading' (duration: 172.560756ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:26:47.317799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.585692ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-16T00:26:47.31808Z","caller":"traceutil/trace.go:171","msg":"trace[1135969851] linearizableReadLoop","detail":"{readStateIndex:9264; appliedIndex:9262; }","duration":"261.403486ms","start":"2026-10-16T00:26:47.056661Z","end":"2026-10-16T00:26:47.318064Z","steps":["trace[1135969851] 'read index received' (duration: 134.492096ms)","trace[1135969851] 'applied index is now lower than readState.Index' (duration: 126.91019ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:26:47.318177Z","caller":"traceutil/trace.go:171","msg":"trace[1363522999] transaction","detail":"{read_only:false; response_revision:8946; number_of_response:1; }","duration":"294.388514ms","start":"2026-10-16T00:26:47.023779Z","end":"2026-10-16T00:26:47.318167Z","steps":["trace[1363522999] 'process raft request' (duration: 167.2725ms)","trace[1363522999] 'compare' (duration: 126.356887ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:26:47.318443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.791385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:26:47.318415Z","caller":"traceutil/trace.go:171","msg":"trace[565094976] transaction","detail":"{read_only:false; response_revision:8949; number_of_response:1; }","duration":"148.833924ms","start":"2026-10-16T00:26:47.169537Z","end":"2026-10-16T00:26:47.318371Z","steps":["trace[565094976] 'process raft request' (duration: 148.493876ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:26:47.318472Z","caller":"traceutil/trace.go:171","msg":"trace[1755562638] transaction","detail":"{read_only:false; response_revision:8947; number_of_response:1; }","duration":"293.330441ms","start":"2026-10-16T00:26:47.025091Z","end":"2026-10-16T00:26:47.318422Z","steps":["trace[1755562638] 'process raft request' (duration: 292.82349ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:26:47.318574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.906348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-98rn8\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-10-16T00:26:47.31847Z","caller":"traceutil/trace.go:171","msg":"trace[1098198382] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8949; }","duration":"261.858567ms","start":"2026-10-16T00:26:47.056604Z","end":"2026-10-16T00:26:47.318463Z","steps":["trace[1098198382] 'agreement among raft nodes before linearized reading' (duration: 261.779875ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:26:47.318571Z","caller":"traceutil/trace.go:171","msg":"trace[1667324405] transaction","detail":"{read_only:false; response_revision:8948; number_of_response:1; }","duration":"163.031306ms","start":"2026-10-16T00:26:47.155513Z","end":"2026-10-16T00:26:47.318545Z","steps":["trace[1667324405] 'process raft request' (duration: 162.488764ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:26:47.31857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.611564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-16T00:26:47.318658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.822309ms","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-16T00:26:47.318662Z","caller":"traceutil/trace.go:171","msg":"trace[677481108] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:8949; }","duration":"253.809359ms","start":"2026-10-16T00:26:47.064832Z","end":"2026-10-16T00:26:47.318641Z","steps":["trace[677481108] 'agreement among raft nodes before linearized reading' (duration: 253.649625ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:26:47.318697Z","caller":"traceutil/trace.go:171","msg":"trace[2097347611] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8949; }","duration":"112.908051ms","start":"2026-10-16T00:26:47.205779Z","end":"2026-10-16T00:26:47.318687Z","steps":["trace[2097347611] 'agreement among raft nodes before linearized reading' (duration: 112.704876ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:26:47.3186Z","caller":"traceutil/trace.go:171","msg":"trace[622742147] range","detail":"{range_begin:/registry/pods/openstack/keepalived-98rn8; range_end:; response_count:1; response_revision:8949; }","duration":"101.961199ms","start":"2026-10-16T00:26:47.216631Z","end":"2026-10-16T00:26:47.318592Z","steps":["trace[622742147] 'agreement among raft nodes before linearized reading' (duration: 101.858187ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:26:47.318802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.960514ms","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-16T00:26:47.318977Z","caller":"traceutil/trace.go:171","msg":"trace[2027665675] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8949; }","duration":"138.104527ms","start":"2026-10-16T00:26:47.180777Z","end":"2026-10-16T00:26:47.318882Z","steps":["trace[2027665675] 'agreement among raft nodes before linearized reading' (duration: 137.748179ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:26:47.637776Z","caller":"traceutil/trace.go:171","msg":"trace[1231342517] linearizableReadLoop","detail":"{readStateIndex:9267; appliedIndex:9266; }","duration":"312.119085ms","start":"2026-10-16T00:26:47.325622Z","end":"2026-10-16T00:26:47.637741Z","steps":["trace[1231342517] 'read index received' (duration: 290.16519ms)","trace[1231342517] 'applied index is now lower than readState.Index' (duration: 21.952795ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:26:47.638019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.370241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-16T00:26:47.638014Z","caller":"traceutil/trace.go:171","msg":"trace[1939729130] transaction","detail":"{read_only:false; response_revision:8950; number_of_response:1; }","duration":"313.219109ms","start":"2026-10-16T00:26:47.32473Z","end":"2026-10-16T00:26:47.637949Z","steps":["trace[1939729130] 'process raft request' (duration: 291.03445ms)","trace[1939729130] 'compare' (duration: 21.538745ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:26:47.638076Z","caller":"traceutil/trace.go:171","msg":"trace[1168237949] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusrules/; range_end:/registry/monitoring.coreos.com/prometheusrules0; response_count:0; response_revision:8950; }","duration":"312.505924ms","start":"2026-10-16T00:26:47.325551Z","end":"2026-10-16T00:26:47.638057Z","steps":["trace[1168237949] 'agreement among raft nodes before linearized reading' (duration: 312.316299ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:26:47.638125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:26:47.325517Z","time spent":"312.595406ms","remote":"127.0.0.1:58960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":32,"response size":31,"request content":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true "} {"level":"warn","ts":"2026-10-16T00:26:47.638215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:26:47.324704Z","time spent":"313.403194ms","remote":"127.0.0.1:39558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:26:47.67033Z","caller":"traceutil/trace.go:171","msg":"trace[1896043128] transaction","detail":"{read_only:false; response_revision:8951; number_of_response:1; }","duration":"344.279515ms","start":"2026-10-16T00:26:47.326016Z","end":"2026-10-16T00:26:47.670295Z","steps":["trace[1896043128] 'process raft request' (duration: 344.023129ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:26:47.670654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:26:47.325994Z","time spent":"344.437668ms","remote":"127.0.0.1:39558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:27:10.864268Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024bc.wal"} {"level":"info","ts":"2026-10-16T00:27:14.760571Z","caller":"traceutil/trace.go:171","msg":"trace[1257131599] transaction","detail":"{read_only:false; response_revision:9146; number_of_response:1; }","duration":"119.798684ms","start":"2026-10-16T00:27:14.640744Z","end":"2026-10-16T00:27:14.760543Z","steps":["trace[1257131599] 'process raft request' (duration: 119.644161ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:27:18.311558Z","caller":"traceutil/trace.go:171","msg":"trace[708650302] linearizableReadLoop","detail":"{readStateIndex:9494; appliedIndex:9493; }","duration":"417.647861ms","start":"2026-10-16T00:27:17.893873Z","end":"2026-10-16T00:27:18.311521Z","steps":["trace[708650302] 'read index received' (duration: 417.327014ms)","trace[708650302] 'applied index is now lower than readState.Index' (duration: 319.407µs)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:27:18.311605Z","caller":"traceutil/trace.go:171","msg":"trace[260749282] transaction","detail":"{read_only:false; response_revision:9168; number_of_response:1; }","duration":"422.456117ms","start":"2026-10-16T00:27:17.889115Z","end":"2026-10-16T00:27:18.311571Z","steps":["trace[260749282] 'process raft request' (duration: 422.179591ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:27:18.311772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:27:17.889098Z","time spent":"422.59005ms","remote":"127.0.0.1:39558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T00:27:18.311841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.937197ms","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-16T00:27:18.311887Z","caller":"traceutil/trace.go:171","msg":"trace[356549513] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9168; }","duration":"418.0444ms","start":"2026-10-16T00:27:17.89383Z","end":"2026-10-16T00:27:18.311874Z","steps":["trace[356549513] 'agreement among raft nodes before linearized reading' (duration: 417.870906ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:27:18.31195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:27:17.893796Z","time spent":"418.144952ms","remote":"127.0.0.1:39558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-16T00:27:18.312027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.359316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:27:18.312147Z","caller":"traceutil/trace.go:171","msg":"trace[804568365] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:9168; }","duration":"187.55969ms","start":"2026-10-16T00:27:18.124563Z","end":"2026-10-16T00:27:18.312123Z","steps":["trace[804568365] 'agreement among raft nodes before linearized reading' (duration: 187.294504ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:27:18.462078Z","caller":"traceutil/trace.go:171","msg":"trace[1400048912] transaction","detail":"{read_only:false; response_revision:9169; number_of_response:1; }","duration":"145.644846ms","start":"2026-10-16T00:27:18.316405Z","end":"2026-10-16T00:27:18.46205Z","steps":["trace[1400048912] 'process raft request' (duration: 143.647051ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:27:20.499829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.262227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-10-16T00:27:20.499941Z","caller":"traceutil/trace.go:171","msg":"trace[381222364] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9178; }","duration":"183.42342ms","start":"2026-10-16T00:27:20.316495Z","end":"2026-10-16T00:27:20.499919Z","steps":["trace[381222364] 'range keys from in-memory index tree' (duration: 183.123954ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:27:31.718628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.575047ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-16T00:27:31.718808Z","caller":"traceutil/trace.go:171","msg":"trace[1280661526] transaction","detail":"{read_only:false; response_revision:9247; number_of_response:1; }","duration":"225.09732ms","start":"2026-10-16T00:27:31.493692Z","end":"2026-10-16T00:27:31.71879Z","steps":["trace[1280661526] 'process raft request' (duration: 59.271909ms)","trace[1280661526] 'compare' (duration: 165.478314ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:27:31.719058Z","caller":"traceutil/trace.go:171","msg":"trace[1939899996] transaction","detail":"{read_only:false; number_of_response:1; response_revision:9248; }","duration":"221.601273ms","start":"2026-10-16T00:27:31.497419Z","end":"2026-10-16T00:27:31.71902Z","steps":["trace[1939899996] 'process raft request' (duration: 221.313177ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:27:31.968619Z","caller":"traceutil/trace.go:171","msg":"trace[1602670442] transaction","detail":"{read_only:false; response_revision:9251; number_of_response:1; }","duration":"197.779807ms","start":"2026-10-16T00:27:31.770815Z","end":"2026-10-16T00:27:31.968595Z","steps":["trace[1602670442] 'process raft request' (duration: 197.735416ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:27:31.968769Z","caller":"traceutil/trace.go:171","msg":"trace[1817845944] transaction","detail":"{read_only:false; response_revision:9249; number_of_response:1; }","duration":"337.429661ms","start":"2026-10-16T00:27:31.6313Z","end":"2026-10-16T00:27:31.968729Z","steps":["trace[1817845944] 'process raft request' (duration: 240.282966ms)","trace[1817845944] 'compare' (duration: 96.742106ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:27:31.968804Z","caller":"traceutil/trace.go:171","msg":"trace[1804029383] linearizableReadLoop","detail":"{readStateIndex:9579; appliedIndex:9575; }","duration":"305.420334ms","start":"2026-10-16T00:27:31.663347Z","end":"2026-10-16T00:27:31.968768Z","steps":["trace[1804029383] 'read index received' (duration: 42.999289ms)","trace[1804029383] 'applied index is now lower than readState.Index' (duration: 262.416745ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:27:31.968967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:27:31.631264Z","time spent":"337.589764ms","remote":"127.0.0.1:39558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:27:31.969076Z","caller":"traceutil/trace.go:171","msg":"trace[1394178498] transaction","detail":"{read_only:false; response_revision:9250; number_of_response:1; }","duration":"308.967912ms","start":"2026-10-16T00:27:31.660049Z","end":"2026-10-16T00:27:31.969016Z","steps":["trace[1394178498] 'process raft request' (duration: 308.448991ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:27:31.969225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:27:31.660029Z","time spent":"309.108225ms","remote":"127.0.0.1:39558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T00:27:31.969488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.145049ms","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-16T00:27:31.969558Z","caller":"traceutil/trace.go:171","msg":"trace[1500745339] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9251; }","duration":"306.254872ms","start":"2026-10-16T00:27:31.663292Z","end":"2026-10-16T00:27:31.969546Z","steps":["trace[1500745339] 'agreement among raft nodes before linearized reading' (duration: 306.083248ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:27:31.969614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:27:31.66327Z","time spent":"306.333844ms","remote":"127.0.0.1:39558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-10-16T00:27:31.969687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.452138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-10-16T00:27:31.969717Z","caller":"traceutil/trace.go:171","msg":"trace[1966220265] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9251; }","duration":"297.53595ms","start":"2026-10-16T00:27:31.672174Z","end":"2026-10-16T00:27:31.96971Z","steps":["trace[1966220265] 'agreement among raft nodes before linearized reading' (duration: 297.418647ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:27:31.969778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.012195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-rh2vr\" ","response":"range_response_count:1 size:4648"} {"level":"info","ts":"2026-10-16T00:27:31.96982Z","caller":"traceutil/trace.go:171","msg":"trace[2006342904] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-rh2vr; range_end:; response_count:1; response_revision:9251; }","duration":"199.094746ms","start":"2026-10-16T00:27:31.770714Z","end":"2026-10-16T00:27:31.969809Z","steps":["trace[2006342904] 'agreement among raft nodes before linearized reading' (duration: 198.947182ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:27:31.970007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.218519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-rh2vr\" ","response":"range_response_count:1 size:4648"} {"level":"info","ts":"2026-10-16T00:27:31.970192Z","caller":"traceutil/trace.go:171","msg":"trace[47758781] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-rh2vr; range_end:; response_count:1; response_revision:9251; }","duration":"247.445954ms","start":"2026-10-16T00:27:31.722733Z","end":"2026-10-16T00:27:31.970179Z","steps":["trace[47758781] 'agreement among raft nodes before linearized reading' (duration: 247.060925ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:27:31.970313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.045173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-98rn8\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-10-16T00:27:31.970369Z","caller":"traceutil/trace.go:171","msg":"trace[982423669] range","detail":"{range_begin:/registry/pods/openstack/keepalived-98rn8; range_end:; response_count:1; response_revision:9251; }","duration":"294.122335ms","start":"2026-10-16T00:27:31.676231Z","end":"2026-10-16T00:27:31.970353Z","steps":["trace[982423669] 'agreement among raft nodes before linearized reading' (duration: 293.91754ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:28:14.143069Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e3e8b7bea2e3a32b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-16T00:28:14.150468Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-16T00:28:14.150593Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-10-16T00:28:57.977197Z","caller":"traceutil/trace.go:171","msg":"trace[648545627] transaction","detail":"{read_only:false; response_revision:10081; number_of_response:1; }","duration":"270.025122ms","start":"2026-10-16T00:28:57.707143Z","end":"2026-10-16T00:28:57.977169Z","steps":["trace[648545627] 'process raft request' (duration: 269.876779ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:28:57.977598Z","caller":"traceutil/trace.go:171","msg":"trace[377168828] linearizableReadLoop","detail":"{readStateIndex:10436; appliedIndex:10436; }","duration":"220.437607ms","start":"2026-10-16T00:28:57.757114Z","end":"2026-10-16T00:28:57.977551Z","steps":["trace[377168828] 'read index received' (duration: 220.416857ms)","trace[377168828] 'applied index is now lower than readState.Index' (duration: 17.17µs)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:28:57.977715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.58258ms","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-16T00:28:57.977817Z","caller":"traceutil/trace.go:171","msg":"trace[1161573664] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:10081; }","duration":"220.684632ms","start":"2026-10-16T00:28:57.757095Z","end":"2026-10-16T00:28:57.97778Z","steps":["trace[1161573664] 'agreement among raft nodes before linearized reading' (duration: 220.545989ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:28:58.0042Z","caller":"traceutil/trace.go:171","msg":"trace[1402964740] transaction","detail":"{read_only:false; response_revision:10082; number_of_response:1; }","duration":"189.860222ms","start":"2026-10-16T00:28:57.814309Z","end":"2026-10-16T00:28:58.004169Z","steps":["trace[1402964740] 'process raft request' (duration: 189.659317ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:28:58.174082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.776091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:28:58.174191Z","caller":"traceutil/trace.go:171","msg":"trace[103485461] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:10082; }","duration":"118.526957ms","start":"2026-10-16T00:28:58.055638Z","end":"2026-10-16T00:28:58.174164Z","steps":["trace[103485461] 'range keys from in-memory index tree' (duration: 117.631337ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:29:32.337549Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7849} {"level":"info","ts":"2026-10-16T00:29:32.435719Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7849,"took":"96.078929ms","hash":1509387300,"current-db-size-bytes":44388352,"current-db-size":"44 MB","current-db-size-in-use-bytes":25309184,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-10-16T00:29:32.435789Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1509387300,"revision":7849,"compact-revision":4806} {"level":"warn","ts":"2026-10-16T00:33:11.38008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.060502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:356"} {"level":"info","ts":"2026-10-16T00:33:11.380203Z","caller":"traceutil/trace.go:171","msg":"trace[1242554412] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:11712; }","duration":"117.184904ms","start":"2026-10-16T00:33:11.262967Z","end":"2026-10-16T00:33:11.380152Z","steps":["trace[1242554412] 'agreement among raft nodes before linearized reading' (duration: 116.9901ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:34:18.2012Z","caller":"traceutil/trace.go:171","msg":"trace[55627599] transaction","detail":"{read_only:false; response_revision:12408; number_of_response:1; }","duration":"113.660535ms","start":"2026-10-16T00:34:18.087506Z","end":"2026-10-16T00:34:18.201166Z","steps":["trace[55627599] 'process raft request' (duration: 113.382539ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:34:18.41535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.457928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:34:18.415416Z","caller":"traceutil/trace.go:171","msg":"trace[972892778] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:12409; }","duration":"140.590281ms","start":"2026-10-16T00:34:18.27481Z","end":"2026-10-16T00:34:18.4154Z","steps":["trace[972892778] 'count revisions from in-memory index tree' (duration: 140.331045ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:34:32.348725Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10320} {"level":"info","ts":"2026-10-16T00:34:32.450604Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10320,"took":"99.205575ms","hash":2869272412,"current-db-size-bytes":44388352,"current-db-size":"44 MB","current-db-size-in-use-bytes":25481216,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-16T00:34:32.450679Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2869272412,"revision":10320,"compact-revision":7849} {"level":"info","ts":"2026-10-16T00:34:39.83737Z","caller":"traceutil/trace.go:171","msg":"trace[514876883] linearizableReadLoop","detail":"{readStateIndex:12965; appliedIndex:12964; }","duration":"116.488468ms","start":"2026-10-16T00:34:39.720856Z","end":"2026-10-16T00:34:39.837344Z","steps":["trace[514876883] 'read index received' (duration: 72.548466ms)","trace[514876883] 'applied index is now lower than readState.Index' (duration: 43.939112ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:34:39.837585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.701163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-908513d1-a2b4-4cb7-a1ed-9ddd4d3ffd90\" ","response":"range_response_count:1 size:1435"} {"level":"info","ts":"2026-10-16T00:34:39.83762Z","caller":"traceutil/trace.go:171","msg":"trace[360720605] range","detail":"{range_begin:/registry/persistentvolumes/pvc-908513d1-a2b4-4cb7-a1ed-9ddd4d3ffd90; range_end:; response_count:1; response_revision:12530; }","duration":"116.778274ms","start":"2026-10-16T00:34:39.720828Z","end":"2026-10-16T00:34:39.837606Z","steps":["trace[360720605] 'agreement among raft nodes before linearized reading' (duration: 116.61334ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:34:39.837597Z","caller":"traceutil/trace.go:171","msg":"trace[1323195446] transaction","detail":"{read_only:false; response_revision:12530; number_of_response:1; }","duration":"184.180875ms","start":"2026-10-16T00:34:39.653382Z","end":"2026-10-16T00:34:39.837562Z","steps":["trace[1323195446] 'process raft request' (duration: 140.1007ms)","trace[1323195446] 'compare' (duration: 43.766678ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:39:32.35776Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12488} {"level":"info","ts":"2026-10-16T00:39:32.442638Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12488,"took":"82.4085ms","hash":3358768775,"current-db-size-bytes":44388352,"current-db-size":"44 MB","current-db-size-in-use-bytes":27799552,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-16T00:39:32.442772Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3358768775,"revision":12488,"compact-revision":10320} {"level":"info","ts":"2026-10-16T00:40:58.848806Z","caller":"traceutil/trace.go:171","msg":"trace[267508576] transaction","detail":"{read_only:false; response_revision:15078; number_of_response:1; }","duration":"113.350817ms","start":"2026-10-16T00:40:58.735423Z","end":"2026-10-16T00:40:58.848774Z","steps":["trace[267508576] 'process raft request' (duration: 113.138932ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:41:15.095381Z","caller":"traceutil/trace.go:171","msg":"trace[1288794350] transaction","detail":"{read_only:false; response_revision:15174; number_of_response:1; }","duration":"103.087239ms","start":"2026-10-16T00:41:14.992263Z","end":"2026-10-16T00:41:15.09535Z","steps":["trace[1288794350] 'process raft request' (duration: 63.712285ms)","trace[1288794350] 'compare' (duration: 38.851112ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:41:16.047568Z","caller":"traceutil/trace.go:171","msg":"trace[1732219265] transaction","detail":"{read_only:false; response_revision:15180; number_of_response:1; }","duration":"209.291277ms","start":"2026-10-16T00:41:15.838244Z","end":"2026-10-16T00:41:16.047535Z","steps":["trace[1732219265] 'process raft request' (duration: 192.112866ms)","trace[1732219265] 'compare' (duration: 16.948166ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:41:16.048022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.169794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-10-16T00:41:16.048096Z","caller":"traceutil/trace.go:171","msg":"trace[1866785398] linearizableReadLoop","detail":"{readStateIndex:15709; appliedIndex:15708; }","duration":"203.692593ms","start":"2026-10-16T00:41:15.843799Z","end":"2026-10-16T00:41:16.047492Z","steps":["trace[1866785398] 'read index received' (duration: 186.552403ms)","trace[1866785398] 'applied index is now lower than readState.Index' (duration: 17.13893ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:41:16.048125Z","caller":"traceutil/trace.go:171","msg":"trace[1001534518] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:15180; }","duration":"204.339148ms","start":"2026-10-16T00:41:15.843762Z","end":"2026-10-16T00:41:16.048101Z","steps":["trace[1001534518] 'agreement among raft nodes before linearized reading' (duration: 203.865277ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:41:39.347201Z","caller":"traceutil/trace.go:171","msg":"trace[206181940] linearizableReadLoop","detail":"{readStateIndex:16036; appliedIndex:16035; }","duration":"107.704562ms","start":"2026-10-16T00:41:39.239472Z","end":"2026-10-16T00:41:39.347177Z","steps":["trace[206181940] 'read index received' (duration: 107.487337ms)","trace[206181940] 'applied index is now lower than readState.Index' (duration: 216.365µs)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:41:39.347282Z","caller":"traceutil/trace.go:171","msg":"trace[179997949] transaction","detail":"{read_only:false; response_revision:15493; number_of_response:1; }","duration":"140.652703ms","start":"2026-10-16T00:41:39.206594Z","end":"2026-10-16T00:41:39.347247Z","steps":["trace[179997949] 'process raft request' (duration: 140.441398ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:41:39.347623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.131971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-10-16T00:41:39.347673Z","caller":"traceutil/trace.go:171","msg":"trace[1771624104] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:15493; }","duration":"108.259274ms","start":"2026-10-16T00:41:39.239399Z","end":"2026-10-16T00:41:39.347658Z","steps":["trace[1771624104] 'agreement among raft nodes before linearized reading' (duration: 107.908676ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:42:55.917901Z","caller":"traceutil/trace.go:171","msg":"trace[1175879967] linearizableReadLoop","detail":"{readStateIndex:16816; appliedIndex:16815; }","duration":"136.462384ms","start":"2026-10-16T00:42:55.781412Z","end":"2026-10-16T00:42:55.917875Z","steps":["trace[1175879967] 'read index received' (duration: 136.321981ms)","trace[1175879967] 'applied index is now lower than readState.Index' (duration: 139.463µs)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:42:55.917969Z","caller":"traceutil/trace.go:171","msg":"trace[568708287] transaction","detail":"{read_only:false; response_revision:16252; number_of_response:1; }","duration":"138.069759ms","start":"2026-10-16T00:42:55.779866Z","end":"2026-10-16T00:42:55.917936Z","steps":["trace[568708287] 'process raft request' (duration: 137.820414ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:42:55.918242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.808921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"info","ts":"2026-10-16T00:42:55.918325Z","caller":"traceutil/trace.go:171","msg":"trace[820390119] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16252; }","duration":"136.939304ms","start":"2026-10-16T00:42:55.781364Z","end":"2026-10-16T00:42:55.918304Z","steps":["trace[820390119] 'agreement among raft nodes before linearized reading' (duration: 136.697039ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:42:55.925087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.976336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-10-16T00:42:55.925074Z","caller":"traceutil/trace.go:171","msg":"trace[295410611] transaction","detail":"{read_only:false; response_revision:16253; number_of_response:1; }","duration":"139.725515ms","start":"2026-10-16T00:42:55.785242Z","end":"2026-10-16T00:42:55.924968Z","steps":["trace[295410611] 'process raft request' (duration: 139.546391ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:42:55.925183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.31216ms","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-16T00:42:55.925147Z","caller":"traceutil/trace.go:171","msg":"trace[1145102029] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:16253; }","duration":"128.065819ms","start":"2026-10-16T00:42:55.797064Z","end":"2026-10-16T00:42:55.92513Z","steps":["trace[1145102029] 'agreement among raft nodes before linearized reading' (duration: 127.841924ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:42:55.925323Z","caller":"traceutil/trace.go:171","msg":"trace[505999280] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:16253; }","duration":"121.441173ms","start":"2026-10-16T00:42:55.803803Z","end":"2026-10-16T00:42:55.925244Z","steps":["trace[505999280] 'agreement among raft nodes before linearized reading' (duration: 121.243299ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:42:56.701692Z","caller":"traceutil/trace.go:171","msg":"trace[2006930118] linearizableReadLoop","detail":"{readStateIndex:16822; appliedIndex:16821; }","duration":"153.330824ms","start":"2026-10-16T00:42:56.548336Z","end":"2026-10-16T00:42:56.701666Z","steps":["trace[2006930118] 'read index received' (duration: 153.199712ms)","trace[2006930118] 'applied index is now lower than readState.Index' (duration: 129.922µs)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:42:56.701797Z","caller":"traceutil/trace.go:171","msg":"trace[1927276696] transaction","detail":"{read_only:false; response_revision:16257; number_of_response:1; }","duration":"170.37787ms","start":"2026-10-16T00:42:56.531383Z","end":"2026-10-16T00:42:56.70176Z","steps":["trace[1927276696] 'process raft request' (duration: 170.146925ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:42:56.701959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.611451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-10-16T00:42:56.702037Z","caller":"traceutil/trace.go:171","msg":"trace[21557068] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:16257; }","duration":"153.721213ms","start":"2026-10-16T00:42:56.548282Z","end":"2026-10-16T00:42:56.702004Z","steps":["trace[21557068] 'agreement among raft nodes before linearized reading' (duration: 153.510588ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:42:56.911878Z","caller":"traceutil/trace.go:171","msg":"trace[1180406029] linearizableReadLoop","detail":"{readStateIndex:16823; appliedIndex:16822; }","duration":"210.108724ms","start":"2026-10-16T00:42:56.701753Z","end":"2026-10-16T00:42:56.911862Z","steps":["trace[1180406029] 'read index received' (duration: 210.016192ms)","trace[1180406029] 'applied index is now lower than readState.Index' (duration: 91.802µs)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:42:56.911955Z","caller":"traceutil/trace.go:171","msg":"trace[1391509823] transaction","detail":"{read_only:false; response_revision:16258; number_of_response:1; }","duration":"211.364062ms","start":"2026-10-16T00:42:56.700556Z","end":"2026-10-16T00:42:56.91192Z","steps":["trace[1391509823] 'process raft request' (duration: 211.202058ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:42:56.911969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.08299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:42:56.912119Z","caller":"traceutil/trace.go:171","msg":"trace[165191628] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:16258; }","duration":"233.287515ms","start":"2026-10-16T00:42:56.678824Z","end":"2026-10-16T00:42:56.912112Z","steps":["trace[165191628] 'agreement among raft nodes before linearized reading' (duration: 233.106731ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:42:57.093985Z","caller":"traceutil/trace.go:171","msg":"trace[496826126] linearizableReadLoop","detail":"{readStateIndex:16825; appliedIndex:16823; }","duration":"182.042956ms","start":"2026-10-16T00:42:56.911919Z","end":"2026-10-16T00:42:57.093962Z","steps":["trace[496826126] 'read index received' (duration: 178.616041ms)","trace[496826126] 'applied index is now lower than readState.Index' (duration: 3.425635ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:42:57.094035Z","caller":"traceutil/trace.go:171","msg":"trace[1212791951] transaction","detail":"{read_only:false; response_revision:16260; number_of_response:1; }","duration":"262.58426ms","start":"2026-10-16T00:42:56.831399Z","end":"2026-10-16T00:42:57.093983Z","steps":["trace[1212791951] 'process raft request' (duration: 262.440466ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:42:57.094193Z","caller":"traceutil/trace.go:171","msg":"trace[931876056] transaction","detail":"{read_only:false; response_revision:16259; number_of_response:1; }","duration":"388.521381ms","start":"2026-10-16T00:42:56.705645Z","end":"2026-10-16T00:42:57.094166Z","steps":["trace[931876056] 'process raft request' (duration: 385.011103ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:42:57.094284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.734353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-d9lk7\" ","response":"range_response_count:1 size:9799"} {"level":"info","ts":"2026-10-16T00:42:57.09433Z","caller":"traceutil/trace.go:171","msg":"trace[220689402] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-d9lk7; range_end:; response_count:1; response_revision:16260; }","duration":"297.795454ms","start":"2026-10-16T00:42:56.796522Z","end":"2026-10-16T00:42:57.094317Z","steps":["trace[220689402] 'agreement among raft nodes before linearized reading' (duration: 297.61717ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:42:57.094328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.427815ms","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-16T00:42:57.094384Z","caller":"traceutil/trace.go:171","msg":"trace[379536301] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:16260; }","duration":"172.515297ms","start":"2026-10-16T00:42:56.921857Z","end":"2026-10-16T00:42:57.094372Z","steps":["trace[379536301] 'agreement among raft nodes before linearized reading' (duration: 172.305683ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:42:57.094468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.920023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"warn","ts":"2026-10-16T00:42:57.094479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.334494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-metadata\" ","response":"range_response_count:1 size:682"} {"level":"info","ts":"2026-10-16T00:42:57.094507Z","caller":"traceutil/trace.go:171","msg":"trace[1240126298] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16260; }","duration":"127.006435ms","start":"2026-10-16T00:42:56.967489Z","end":"2026-10-16T00:42:57.094496Z","steps":["trace[1240126298] 'agreement among raft nodes before linearized reading' (duration: 126.857432ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:42:57.094513Z","caller":"traceutil/trace.go:171","msg":"trace[898181322] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-metadata; range_end:; response_count:1; response_revision:16260; }","duration":"128.377155ms","start":"2026-10-16T00:42:56.966126Z","end":"2026-10-16T00:42:57.094503Z","steps":["trace[898181322] 'agreement among raft nodes before linearized reading' (duration: 128.240872ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:42:57.094332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:42:56.705624Z","time spent":"388.630024ms","remote":"127.0.0.1:39558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T00:42:57.094649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.188266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:42:57.09468Z","caller":"traceutil/trace.go:171","msg":"trace[889641332] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16260; }","duration":"130.264167ms","start":"2026-10-16T00:42:56.964406Z","end":"2026-10-16T00:42:57.094671Z","steps":["trace[889641332] 'agreement among raft nodes before linearized reading' (duration: 130.195215ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:42:57.094708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.486848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:42:57.094737Z","caller":"traceutil/trace.go:171","msg":"trace[8067557] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:0; response_revision:16260; }","duration":"128.534449ms","start":"2026-10-16T00:42:56.966192Z","end":"2026-10-16T00:42:57.094727Z","steps":["trace[8067557] 'agreement among raft nodes before linearized reading' (duration: 128.489788ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:42:57.09474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.266519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"info","ts":"2026-10-16T00:42:57.094774Z","caller":"traceutil/trace.go:171","msg":"trace[1167517861] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16260; }","duration":"116.30131ms","start":"2026-10-16T00:42:56.978464Z","end":"2026-10-16T00:42:57.094765Z","steps":["trace[1167517861] 'agreement among raft nodes before linearized reading' (duration: 116.195678ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:42:57.094818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.590089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-10-16T00:42:57.094852Z","caller":"traceutil/trace.go:171","msg":"trace[1559427451] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:16260; }","duration":"172.63633ms","start":"2026-10-16T00:42:56.922205Z","end":"2026-10-16T00:42:57.094841Z","steps":["trace[1559427451] 'agreement among raft nodes before linearized reading' (duration: 172.542808ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:42:57.094919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.258421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"} {"level":"info","ts":"2026-10-16T00:42:57.094944Z","caller":"traceutil/trace.go:171","msg":"trace[1272001707] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16260; }","duration":"127.304322ms","start":"2026-10-16T00:42:56.967631Z","end":"2026-10-16T00:42:57.094936Z","steps":["trace[1272001707] 'agreement among raft nodes before linearized reading' (duration: 127.20786ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:44:32.36488Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14520} {"level":"info","ts":"2026-10-16T00:44:32.443752Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14520,"took":"76.624816ms","hash":524252161,"current-db-size-bytes":44388352,"current-db-size":"44 MB","current-db-size-in-use-bytes":31092736,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-16T00:44:32.443821Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":524252161,"revision":14520,"compact-revision":12488} {"level":"info","ts":"2026-10-16T00:49:07.575158Z","caller":"traceutil/trace.go:171","msg":"trace[1284095523] linearizableReadLoop","detail":"{readStateIndex:19618; appliedIndex:19617; }","duration":"246.696035ms","start":"2026-10-16T00:49:07.328421Z","end":"2026-10-16T00:49:07.575117Z","steps":["trace[1284095523] 'read index received' (duration: 246.498761ms)","trace[1284095523] 'applied index is now lower than readState.Index' (duration: 196.224µs)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:49:07.575299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.849038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-16T00:49:07.575335Z","caller":"traceutil/trace.go:171","msg":"trace[1382987146] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:18962; }","duration":"246.946491ms","start":"2026-10-16T00:49:07.328378Z","end":"2026-10-16T00:49:07.575324Z","steps":["trace[1382987146] 'agreement among raft nodes before linearized reading' (duration: 246.845228ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:49:07.5754Z","caller":"traceutil/trace.go:171","msg":"trace[775290755] transaction","detail":"{read_only:false; response_revision:18962; number_of_response:1; }","duration":"316.592702ms","start":"2026-10-16T00:49:07.25876Z","end":"2026-10-16T00:49:07.575353Z","steps":["trace[775290755] 'process raft request' (duration: 316.127952ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:49:07.575625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:49:07.258739Z","time spent":"316.775146ms","remote":"127.0.0.1:39486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20877,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:49:07.596716Z","caller":"traceutil/trace.go:171","msg":"trace[1553802501] transaction","detail":"{read_only:false; response_revision:18964; number_of_response:1; }","duration":"182.34322ms","start":"2026-10-16T00:49:07.414334Z","end":"2026-10-16T00:49:07.596677Z","steps":["trace[1553802501] 'process raft request' (duration: 182.262188ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:49:07.597276Z","caller":"traceutil/trace.go:171","msg":"trace[1898215716] transaction","detail":"{read_only:false; response_revision:18963; number_of_response:1; }","duration":"256.139952ms","start":"2026-10-16T00:49:07.341094Z","end":"2026-10-16T00:49:07.597234Z","steps":["trace[1898215716] 'process raft request' (duration: 255.294194ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:49:07.954035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.152032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-d9lk7\" ","response":"range_response_count:1 size:9800"} {"level":"info","ts":"2026-10-16T00:49:07.954167Z","caller":"traceutil/trace.go:171","msg":"trace[944807514] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-d9lk7; range_end:; response_count:1; response_revision:18964; }","duration":"140.384947ms","start":"2026-10-16T00:49:07.813753Z","end":"2026-10-16T00:49:07.954138Z","steps":["trace[944807514] 'range keys from in-memory index tree' (duration: 139.818715ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:49:07.954746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.895689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-nova-server-0\" ","response":"range_response_count:1 size:1850"} {"level":"info","ts":"2026-10-16T00:49:07.954828Z","caller":"traceutil/trace.go:171","msg":"trace[876755193] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-nova-server-0; range_end:; response_count:1; response_revision:18964; }","duration":"297.042283ms","start":"2026-10-16T00:49:07.657766Z","end":"2026-10-16T00:49:07.954809Z","steps":["trace[876755193] 'range keys from in-memory index tree' (duration: 296.746216ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:49:07.954895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.932801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-10-16T00:49:07.954976Z","caller":"traceutil/trace.go:171","msg":"trace[905163792] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18964; }","duration":"172.053583ms","start":"2026-10-16T00:49:07.782905Z","end":"2026-10-16T00:49:07.954959Z","steps":["trace[905163792] 'range keys from in-memory index tree' (duration: 171.762018ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:49:08.50121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.503225ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-16T00:49:08.501343Z","caller":"traceutil/trace.go:171","msg":"trace[612650529] linearizableReadLoop","detail":"{readStateIndex:19623; appliedIndex:19622; }","duration":"439.687828ms","start":"2026-10-16T00:49:08.061633Z","end":"2026-10-16T00:49:08.50132Z","steps":["trace[612650529] 'read index received' (duration: 24.743904ms)","trace[612650529] 'applied index is now lower than readState.Index' (duration: 414.942084ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:49:08.501432Z","caller":"traceutil/trace.go:171","msg":"trace[1522441077] transaction","detail":"{read_only:false; response_revision:18967; number_of_response:1; }","duration":"494.33725ms","start":"2026-10-16T00:49:08.007081Z","end":"2026-10-16T00:49:08.501419Z","steps":["trace[1522441077] 'process raft request' (duration: 79.236573ms)","trace[1522441077] 'compare' (duration: 413.728317ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:49:08.501501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:49:08.007038Z","time spent":"494.427602ms","remote":"127.0.0.1:39558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T00:49:08.501743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.115437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-16T00:49:08.501777Z","caller":"traceutil/trace.go:171","msg":"trace[1850992032] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18967; }","duration":"440.202799ms","start":"2026-10-16T00:49:08.061565Z","end":"2026-10-16T00:49:08.501768Z","steps":["trace[1850992032] 'agreement among raft nodes before linearized reading' (duration: 440.135487ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:49:08.501814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:49:08.061537Z","time spent":"440.268471ms","remote":"127.0.0.1:39288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-16T00:49:08.69917Z","caller":"traceutil/trace.go:171","msg":"trace[346879312] linearizableReadLoop","detail":"{readStateIndex:19624; appliedIndex:19623; }","duration":"197.77312ms","start":"2026-10-16T00:49:08.50137Z","end":"2026-10-16T00:49:08.699143Z","steps":["trace[346879312] 'read index received' (duration: 197.551855ms)","trace[346879312] 'applied index is now lower than readState.Index' (duration: 220.455µs)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:49:08.699642Z","caller":"traceutil/trace.go:171","msg":"trace[417825648] transaction","detail":"{read_only:false; response_revision:18968; number_of_response:1; }","duration":"397.954051ms","start":"2026-10-16T00:49:08.301672Z","end":"2026-10-16T00:49:08.699626Z","steps":["trace[417825648] 'process raft request' (duration: 397.342418ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:49:08.699837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:49:08.301614Z","time spent":"398.069164ms","remote":"127.0.0.1:39558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T00:49:08.700383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.134955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-16T00:49:08.700484Z","caller":"traceutil/trace.go:171","msg":"trace[1557014913] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18968; }","duration":"197.291958ms","start":"2026-10-16T00:49:08.503167Z","end":"2026-10-16T00:49:08.700459Z","steps":["trace[1557014913] 'agreement among raft nodes before linearized reading' (duration: 197.107184ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:49:08.700651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.316839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-rk2hr\" ","response":"range_response_count:1 size:22133"} {"level":"info","ts":"2026-10-16T00:49:08.700714Z","caller":"traceutil/trace.go:171","msg":"trace[186037444] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-rk2hr; range_end:; response_count:1; response_revision:18968; }","duration":"529.418922ms","start":"2026-10-16T00:49:08.17128Z","end":"2026-10-16T00:49:08.700699Z","steps":["trace[186037444] 'agreement among raft nodes before linearized reading' (duration: 529.153916ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:49:08.700763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:49:08.171257Z","time spent":"529.495913ms","remote":"127.0.0.1:39486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22157,"request content":"key:\"/registry/pods/openstack/nova-compute-default-rk2hr\" "} {"level":"info","ts":"2026-10-16T00:49:14.629762Z","caller":"traceutil/trace.go:171","msg":"trace[48663153] transaction","detail":"{read_only:false; response_revision:19077; number_of_response:1; }","duration":"107.442373ms","start":"2026-10-16T00:49:14.522292Z","end":"2026-10-16T00:49:14.629734Z","steps":["trace[48663153] 'process raft request' (duration: 106.897761ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:49:32.372514Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16880} {"level":"info","ts":"2026-10-16T00:49:32.476832Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16880,"took":"100.884358ms","hash":36034091,"current-db-size-bytes":45232128,"current-db-size":"45 MB","current-db-size-in-use-bytes":32706560,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-16T00:49:32.476906Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":36034091,"revision":16880,"compact-revision":14520} {"level":"info","ts":"2026-10-16T00:49:44.737732Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e3e8b7bea2e3a32b","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-16T00:49:44.744794Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-16T00:49:44.744907Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-10-16T00:54:32.380099Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19258} {"level":"info","ts":"2026-10-16T00:54:32.483505Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19258,"took":"100.012437ms","hash":592740000,"current-db-size-bytes":46501888,"current-db-size":"46 MB","current-db-size-in-use-bytes":33681408,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-10-16T00:54:32.483582Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":592740000,"revision":19258,"compact-revision":16880} {"level":"info","ts":"2026-10-16T00:54:39.932772Z","caller":"traceutil/trace.go:171","msg":"trace[784142176] transaction","detail":"{read_only:false; response_revision:21581; number_of_response:1; }","duration":"238.349409ms","start":"2026-10-16T00:54:39.694386Z","end":"2026-10-16T00:54:39.932735Z","steps":["trace[784142176] 'process raft request' (duration: 151.959583ms)","trace[784142176] 'compare' (duration: 85.968367ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:54:40.238289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.278331ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-16T00:54:40.23838Z","caller":"traceutil/trace.go:171","msg":"trace[565874319] linearizableReadLoop","detail":"{readStateIndex:22325; appliedIndex:22324; }","duration":"192.381195ms","start":"2026-10-16T00:54:40.045981Z","end":"2026-10-16T00:54:40.238362Z","steps":["trace[565874319] 'read index received' (duration: 24.505251ms)","trace[565874319] 'applied index is now lower than readState.Index' (duration: 167.875004ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:54:40.238466Z","caller":"traceutil/trace.go:171","msg":"trace[1932885014] transaction","detail":"{read_only:false; response_revision:21584; number_of_response:1; }","duration":"290.664374ms","start":"2026-10-16T00:54:39.947788Z","end":"2026-10-16T00:54:40.238453Z","steps":["trace[1932885014] 'process raft request' (duration: 123.139137ms)","trace[1932885014] 'compare' (duration: 166.917463ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:54:40.238663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.951537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-16T00:54:40.238731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.754314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-16T00:54:40.238743Z","caller":"traceutil/trace.go:171","msg":"trace[637893167] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21584; }","duration":"178.072879ms","start":"2026-10-16T00:54:40.060648Z","end":"2026-10-16T00:54:40.238721Z","steps":["trace[637893167] 'agreement among raft nodes before linearized reading' (duration: 177.941426ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:54:40.238769Z","caller":"traceutil/trace.go:171","msg":"trace[1273139764] range","detail":"{range_begin:/registry/secretgen.k14s.io/certificates/; range_end:/registry/secretgen.k14s.io/certificates0; response_count:0; response_revision:21584; }","duration":"192.836535ms","start":"2026-10-16T00:54:40.045924Z","end":"2026-10-16T00:54:40.23876Z","steps":["trace[1273139764] 'agreement among raft nodes before linearized reading' (duration: 192.761914ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:54:56.134814Z","caller":"traceutil/trace.go:171","msg":"trace[976128854] linearizableReadLoop","detail":"{readStateIndex:22409; appliedIndex:22408; }","duration":"260.12967ms","start":"2026-10-16T00:54:55.87463Z","end":"2026-10-16T00:54:56.13476Z","steps":["trace[976128854] 'read index received' (duration: 253.096254ms)","trace[976128854] 'applied index is now lower than readState.Index' (duration: 7.032076ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:54:56.134972Z","caller":"traceutil/trace.go:171","msg":"trace[616677189] transaction","detail":"{read_only:false; response_revision:21664; number_of_response:1; }","duration":"267.518483ms","start":"2026-10-16T00:54:55.867442Z","end":"2026-10-16T00:54:56.13496Z","steps":["trace[616677189] 'process raft request' (duration: 260.349675ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:54:56.13521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.560929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.128\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-10-16T00:54:56.1353Z","caller":"traceutil/trace.go:171","msg":"trace[647227293] range","detail":"{range_begin:/registry/masterleases/162.253.55.128; range_end:; response_count:1; response_revision:21664; }","duration":"260.681902ms","start":"2026-10-16T00:54:55.874595Z","end":"2026-10-16T00:54:56.135277Z","steps":["trace[647227293] 'agreement among raft nodes before linearized reading' (duration: 260.439297ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:54:56.5639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.033379ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-16T00:54:56.564127Z","caller":"traceutil/trace.go:171","msg":"trace[613294969] linearizableReadLoop","detail":"{readStateIndex:22411; appliedIndex:22409; }","duration":"429.19919ms","start":"2026-10-16T00:54:56.13491Z","end":"2026-10-16T00:54:56.564109Z","steps":["trace[613294969] 'read index received' (duration: 119.858064ms)","trace[613294969] 'applied index is now lower than readState.Index' (duration: 309.340156ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:54:56.564216Z","caller":"traceutil/trace.go:171","msg":"trace[30277178] transaction","detail":"{read_only:false; response_revision:21666; number_of_response:1; }","duration":"487.865234ms","start":"2026-10-16T00:54:56.076342Z","end":"2026-10-16T00:54:56.564207Z","steps":["trace[30277178] 'process raft request' (duration: 487.68012ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:54:56.56428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:54:56.076309Z","time spent":"487.936016ms","remote":"127.0.0.1:39558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:54:56.564281Z","caller":"traceutil/trace.go:171","msg":"trace[1391115677] transaction","detail":"{read_only:false; response_revision:21665; number_of_response:1; }","duration":"571.51409ms","start":"2026-10-16T00:54:55.992555Z","end":"2026-10-16T00:54:56.564069Z","steps":["trace[1391115677] 'process raft request' (duration: 262.228276ms)","trace[1391115677] 'compare' (duration: 308.932457ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:54:56.564613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:54:55.992526Z","time spent":"571.93555ms","remote":"127.0.0.1:39558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T00:54:56.565063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.238795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/heat-api-6d65745f97-mhcgf.18dedc58d88f3a22\" ","response":"range_response_count:1 size:906"} {"level":"warn","ts":"2026-10-16T00:54:56.565171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.736904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-16T00:54:56.565166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.218107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-10-16T00:54:56.565211Z","caller":"traceutil/trace.go:171","msg":"trace[1506899860] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:21666; }","duration":"120.817416ms","start":"2026-10-16T00:54:56.444381Z","end":"2026-10-16T00:54:56.565199Z","steps":["trace[1506899860] 'agreement among raft nodes before linearized reading' (duration: 120.753855ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:54:56.565216Z","caller":"traceutil/trace.go:171","msg":"trace[266374677] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:21666; }","duration":"103.291669ms","start":"2026-10-16T00:54:56.461913Z","end":"2026-10-16T00:54:56.565205Z","steps":["trace[266374677] 'agreement among raft nodes before linearized reading' (duration: 103.110475ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:54:56.565221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:54:56.136686Z","time spent":"428.526666ms","remote":"127.0.0.1:39316","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-10-16T00:54:56.565257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.063773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-10-16T00:54:56.565305Z","caller":"traceutil/trace.go:171","msg":"trace[2050480918] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21666; }","duration":"558.140365ms","start":"2026-10-16T00:54:56.00715Z","end":"2026-10-16T00:54:56.56529Z","steps":["trace[2050480918] 'agreement among raft nodes before linearized reading' (duration: 557.261986ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:54:56.565344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:54:56.007137Z","time spent":"558.198086ms","remote":"127.0.0.1:39558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":519,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-16T00:54:56.565214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.478265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-16T00:54:56.565209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.425164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-16T00:54:56.565499Z","caller":"traceutil/trace.go:171","msg":"trace[183071681] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21666; }","duration":"380.816393ms","start":"2026-10-16T00:54:56.184672Z","end":"2026-10-16T00:54:56.565489Z","steps":["trace[183071681] 'agreement among raft nodes before linearized reading' (duration: 380.443224ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:54:56.565533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:54:56.184652Z","time spent":"380.871313ms","remote":"127.0.0.1:39288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-16T00:54:56.565606Z","caller":"traceutil/trace.go:171","msg":"trace[1916656107] range","detail":"{range_begin:/registry/events/openstack/heat-api-6d65745f97-mhcgf.18dedc58d88f3a22; range_end:; response_count:1; response_revision:21666; }","duration":"426.327126ms","start":"2026-10-16T00:54:56.13878Z","end":"2026-10-16T00:54:56.565107Z","steps":["trace[1916656107] 'agreement among raft nodes before linearized reading' (duration: 426.126422ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:54:56.565652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:54:56.138761Z","time spent":"426.880529ms","remote":"127.0.0.1:39382","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":930,"request content":"key:\"/registry/events/openstack/heat-api-6d65745f97-mhcgf.18dedc58d88f3a22\" "} {"level":"info","ts":"2026-10-16T00:54:56.565699Z","caller":"traceutil/trace.go:171","msg":"trace[21802946] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:21666; }","duration":"370.833722ms","start":"2026-10-16T00:54:56.194665Z","end":"2026-10-16T00:54:56.565499Z","steps":["trace[21802946] 'agreement among raft nodes before linearized reading' (duration: 370.386032ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:54:56.565809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:54:56.194654Z","time spent":"371.089488ms","remote":"127.0.0.1:52010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"info","ts":"2026-10-16T00:54:56.769656Z","caller":"traceutil/trace.go:171","msg":"trace[1794098145] transaction","detail":"{read_only:false; response_revision:21667; number_of_response:1; }","duration":"203.299756ms","start":"2026-10-16T00:54:56.56633Z","end":"2026-10-16T00:54:56.76963Z","steps":["trace[1794098145] 'process raft request' (duration: 147.221528ms)","trace[1794098145] 'compare' (duration: 55.541506ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:54:56.769727Z","caller":"traceutil/trace.go:171","msg":"trace[369835745] transaction","detail":"{read_only:false; response_revision:21668; number_of_response:1; }","duration":"200.928403ms","start":"2026-10-16T00:54:56.568753Z","end":"2026-10-16T00:54:56.769682Z","steps":["trace[369835745] 'process raft request' (duration: 200.718929ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:54:56.769845Z","caller":"traceutil/trace.go:171","msg":"trace[355686716] transaction","detail":"{read_only:false; response_revision:21669; number_of_response:1; }","duration":"199.203136ms","start":"2026-10-16T00:54:56.570632Z","end":"2026-10-16T00:54:56.769835Z","steps":["trace[355686716] 'process raft request' (duration: 198.980991ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:54:57.106583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.205152ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-16T00:54:57.106702Z","caller":"traceutil/trace.go:171","msg":"trace[1822551459] transaction","detail":"{read_only:false; response_revision:21670; number_of_response:1; }","duration":"332.955627ms","start":"2026-10-16T00:54:56.773721Z","end":"2026-10-16T00:54:57.106677Z","steps":["trace[1822551459] 'process raft request' (duration: 169.518261ms)","trace[1822551459] 'compare' (duration: 162.906414ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:54:57.106786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:54:56.773699Z","time spent":"333.042558ms","remote":"127.0.0.1:39558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:54:57.156623Z","caller":"traceutil/trace.go:171","msg":"trace[1987317157] transaction","detail":"{read_only:false; response_revision:21671; number_of_response:1; }","duration":"382.870778ms","start":"2026-10-16T00:54:56.773724Z","end":"2026-10-16T00:54:57.156594Z","steps":["trace[1987317157] 'process raft request' (duration: 382.705604ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:54:57.156772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:54:56.773699Z","time spent":"382.99574ms","remote":"127.0.0.1:39558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:54:57.156856Z","caller":"traceutil/trace.go:171","msg":"trace[876516409] linearizableReadLoop","detail":"{readStateIndex:22417; appliedIndex:22415; }","duration":"383.074063ms","start":"2026-10-16T00:54:56.773766Z","end":"2026-10-16T00:54:57.15684Z","steps":["trace[876516409] 'read index received' (duration: 169.578382ms)","trace[876516409] 'applied index is now lower than readState.Index' (duration: 213.494591ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:54:57.156918Z","caller":"traceutil/trace.go:171","msg":"trace[1209148818] transaction","detail":"{read_only:false; response_revision:21673; number_of_response:1; }","duration":"246.357126ms","start":"2026-10-16T00:54:56.910536Z","end":"2026-10-16T00:54:57.156893Z","steps":["trace[1209148818] 'process raft request' (duration: 246.228193ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:54:57.1571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.323468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-10-16T00:54:57.157147Z","caller":"traceutil/trace.go:171","msg":"trace[664235407] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:21673; }","duration":"383.402619ms","start":"2026-10-16T00:54:56.773734Z","end":"2026-10-16T00:54:57.157137Z","steps":["trace[664235407] 'agreement among raft nodes before linearized reading' (duration: 383.192834ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:54:57.157175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:54:56.773716Z","time spent":"383.451301ms","remote":"127.0.0.1:39316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":164,"request content":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" "} {"level":"info","ts":"2026-10-16T00:54:57.156922Z","caller":"traceutil/trace.go:171","msg":"trace[763906408] transaction","detail":"{read_only:false; response_revision:21672; number_of_response:1; }","duration":"249.752481ms","start":"2026-10-16T00:54:56.907139Z","end":"2026-10-16T00:54:57.156891Z","steps":["trace[763906408] 'process raft request' (duration: 249.415273ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:54:57.157228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.232526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-10-16T00:54:57.157285Z","caller":"traceutil/trace.go:171","msg":"trace[1729281597] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:21673; }","duration":"383.323868ms","start":"2026-10-16T00:54:56.773948Z","end":"2026-10-16T00:54:57.157272Z","steps":["trace[1729281597] 'agreement among raft nodes before linearized reading' (duration: 383.119274ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:54:57.157324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:54:56.773938Z","time spent":"383.377229ms","remote":"127.0.0.1:39486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-10-16T00:54:57.157342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.471587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-16T00:54:57.157402Z","caller":"traceutil/trace.go:171","msg":"trace[423059764] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21673; }","duration":"100.57435ms","start":"2026-10-16T00:54:57.056811Z","end":"2026-10-16T00:54:57.157385Z","steps":["trace[423059764] 'agreement among raft nodes before linearized reading' (duration: 100.489968ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:54:57.157613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.71ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-16T00:54:57.157688Z","caller":"traceutil/trace.go:171","msg":"trace[2122376368] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21673; }","duration":"351.832633ms","start":"2026-10-16T00:54:56.805837Z","end":"2026-10-16T00:54:57.157669Z","steps":["trace[2122376368] 'agreement among raft nodes before linearized reading' (duration: 351.555607ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:54:57.1578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:54:56.805821Z","time spent":"351.963626ms","remote":"127.0.0.1:39558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-16T00:54:57.45759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.911272ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-16T00:54:57.458028Z","caller":"traceutil/trace.go:171","msg":"trace[2118761322] transaction","detail":"{read_only:false; response_revision:21674; number_of_response:1; }","duration":"296.267217ms","start":"2026-10-16T00:54:57.161709Z","end":"2026-10-16T00:54:57.457976Z","steps":["trace[2118761322] 'process raft request' (duration: 138.868374ms)","trace[2118761322] 'compare' (duration: 156.784559ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:54:57.458078Z","caller":"traceutil/trace.go:171","msg":"trace[1152561252] linearizableReadLoop","detail":"{readStateIndex:22420; appliedIndex:22419; }","duration":"226.737003ms","start":"2026-10-16T00:54:57.23123Z","end":"2026-10-16T00:54:57.457967Z","steps":["trace[1152561252] 'read index received' (duration: 69.37424ms)","trace[1152561252] 'applied index is now lower than readState.Index' (duration: 157.361153ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:54:57.458156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.897176ms","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-16T00:54:57.458251Z","caller":"traceutil/trace.go:171","msg":"trace[1272697726] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:21674; }","duration":"227.039069ms","start":"2026-10-16T00:54:57.231189Z","end":"2026-10-16T00:54:57.458228Z","steps":["trace[1272697726] 'agreement among raft nodes before linearized reading' (duration: 226.869256ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:58:53.542089Z","caller":"traceutil/trace.go:171","msg":"trace[111157399] transaction","detail":"{read_only:false; response_revision:24147; number_of_response:1; }","duration":"121.43211ms","start":"2026-10-16T00:58:53.420632Z","end":"2026-10-16T00:58:53.542064Z","steps":["trace[111157399] 'process raft request' (duration: 121.270636ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:58:54.002317Z","caller":"traceutil/trace.go:171","msg":"trace[1210578011] transaction","detail":"{read_only:false; response_revision:24150; number_of_response:1; }","duration":"230.71797ms","start":"2026-10-16T00:58:53.77157Z","end":"2026-10-16T00:58:54.002288Z","steps":["trace[1210578011] 'process raft request' (duration: 230.580947ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:59:32.390951Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21544} {"level":"info","ts":"2026-10-16T00:59:32.503674Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21544,"took":"109.813943ms","hash":3000215306,"current-db-size-bytes":51630080,"current-db-size":"52 MB","current-db-size-in-use-bytes":42373120,"current-db-size-in-use":"42 MB"} {"level":"info","ts":"2026-10-16T00:59:32.503755Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3000215306,"revision":21544,"compact-revision":19258} {"level":"info","ts":"2026-10-16T01:01:31.953524Z","caller":"traceutil/trace.go:171","msg":"trace[2126131414] transaction","detail":"{read_only:false; response_revision:25816; number_of_response:1; }","duration":"109.382983ms","start":"2026-10-16T01:01:31.844107Z","end":"2026-10-16T01:01:31.95349Z","steps":["trace[2126131414] 'process raft request' (duration: 103.79014ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T01:01:31.957495Z","caller":"traceutil/trace.go:171","msg":"trace[1516715121] transaction","detail":"{read_only:false; response_revision:25818; number_of_response:1; }","duration":"109.483186ms","start":"2026-10-16T01:01:31.847978Z","end":"2026-10-16T01:01:31.957461Z","steps":["trace[1516715121] 'process raft request' (duration: 109.340573ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T01:01:31.957557Z","caller":"traceutil/trace.go:171","msg":"trace[257594733] transaction","detail":"{read_only:false; response_revision:25817; number_of_response:1; }","duration":"112.86732ms","start":"2026-10-16T01:01:31.844623Z","end":"2026-10-16T01:01:31.957491Z","steps":["trace[257594733] 'process raft request' (duration: 112.553163ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T01:01:51.959171Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000068d9.wal"} {"level":"warn","ts":"2026-10-16T01:02:06.590415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.491709ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-16T01:02:06.590791Z","caller":"traceutil/trace.go:171","msg":"trace[557941771] transaction","detail":"{read_only:false; response_revision:26156; number_of_response:1; }","duration":"198.029679ms","start":"2026-10-16T01:02:06.392741Z","end":"2026-10-16T01:02:06.590771Z","steps":["trace[557941771] 'process raft request' (duration: 96.0891ms)","trace[557941771] 'compare' (duration: 101.301485ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T01:02:06.591238Z","caller":"traceutil/trace.go:171","msg":"trace[172151353] transaction","detail":"{read_only:false; response_revision:26157; number_of_response:1; }","duration":"157.640048ms","start":"2026-10-16T01:02:06.433568Z","end":"2026-10-16T01:02:06.591208Z","steps":["trace[172151353] 'process raft request' (duration: 157.049085ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T01:02:12.288645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.655012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-16T01:02:12.288728Z","caller":"traceutil/trace.go:171","msg":"trace[138135668] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26198; }","duration":"232.786345ms","start":"2026-10-16T01:02:12.055923Z","end":"2026-10-16T01:02:12.288709Z","steps":["trace[138135668] 'range keys from in-memory index tree' (duration: 232.56688ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T01:02:12.290038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.86657ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-16T01:02:12.290241Z","caller":"traceutil/trace.go:171","msg":"trace[1751413610] transaction","detail":"{read_only:false; response_revision:26199; number_of_response:1; }","duration":"151.643866ms","start":"2026-10-16T01:02:12.138567Z","end":"2026-10-16T01:02:12.290211Z","steps":["trace[1751413610] 'compare' (duration: 146.254517ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T01:02:12.65231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.216226ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-16T01:02:12.652528Z","caller":"traceutil/trace.go:171","msg":"trace[1431901077] linearizableReadLoop","detail":"{readStateIndex:27067; appliedIndex:27065; }","duration":"121.94663ms","start":"2026-10-16T01:02:12.530564Z","end":"2026-10-16T01:02:12.65251Z","steps":["trace[1431901077] 'read index received' (duration: 21.368471ms)","trace[1431901077] 'applied index is now lower than readState.Index' (duration: 100.577009ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T01:02:12.652601Z","caller":"traceutil/trace.go:171","msg":"trace[996679692] transaction","detail":"{read_only:false; response_revision:26200; number_of_response:1; }","duration":"358.04878ms","start":"2026-10-16T01:02:12.294541Z","end":"2026-10-16T01:02:12.65259Z","steps":["trace[996679692] 'process raft request' (duration: 172.438385ms)","trace[996679692] 'compare' (duration: 184.91892ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T01:02:12.652664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T01:02:12.294506Z","time spent":"358.124891ms","remote":"127.0.0.1:39558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T01:02:12.652863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.292968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtime.cluster.x-k8s.io/extensionconfigs/\" range_end:\"/registry/runtime.cluster.x-k8s.io/extensionconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-16T01:02:12.65285Z","caller":"traceutil/trace.go:171","msg":"trace[661706509] transaction","detail":"{read_only:false; response_revision:26201; number_of_response:1; }","duration":"317.111366ms","start":"2026-10-16T01:02:12.335711Z","end":"2026-10-16T01:02:12.652822Z","steps":["trace[661706509] 'process raft request' (duration: 316.714947ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T01:02:12.652902Z","caller":"traceutil/trace.go:171","msg":"trace[1579536350] range","detail":"{range_begin:/registry/runtime.cluster.x-k8s.io/extensionconfigs/; range_end:/registry/runtime.cluster.x-k8s.io/extensionconfigs0; response_count:0; response_revision:26201; }","duration":"122.333989ms","start":"2026-10-16T01:02:12.530557Z","end":"2026-10-16T01:02:12.652891Z","steps":["trace[1579536350] 'agreement among raft nodes before linearized reading' (duration: 122.271057ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T01:02:12.652957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T01:02:12.335681Z","time spent":"317.223459ms","remote":"127.0.0.1:39558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T01:02:12.902272Z","caller":"traceutil/trace.go:171","msg":"trace[1749900807] transaction","detail":"{read_only:false; response_revision:26202; number_of_response:1; }","duration":"292.570485ms","start":"2026-10-16T01:02:12.609675Z","end":"2026-10-16T01:02:12.902246Z","steps":["trace[1749900807] 'process raft request' (duration: 227.014269ms)","trace[1749900807] 'compare' (duration: 65.368722ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T01:02:12.960829Z","caller":"traceutil/trace.go:171","msg":"trace[1903087408] transaction","detail":"{read_only:false; response_revision:26203; number_of_response:1; }","duration":"350.088504ms","start":"2026-10-16T01:02:12.610712Z","end":"2026-10-16T01:02:12.9608Z","steps":["trace[1903087408] 'process raft request' (duration: 349.718626ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T01:02:12.960973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T01:02:12.610683Z","time spent":"350.216267ms","remote":"127.0.0.1:39558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T01:02:12.960959Z","caller":"traceutil/trace.go:171","msg":"trace[283672844] transaction","detail":"{read_only:false; response_revision:26204; number_of_response:1; }","duration":"190.565194ms","start":"2026-10-16T01:02:12.770381Z","end":"2026-10-16T01:02:12.960946Z","steps":["trace[283672844] 'process raft request' (duration: 190.177325ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T01:02:12.9612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.891215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-16T01:02:12.961239Z","caller":"traceutil/trace.go:171","msg":"trace[1341491484] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:26204; }","duration":"313.993767ms","start":"2026-10-16T01:02:12.647232Z","end":"2026-10-16T01:02:12.961226Z","steps":["trace[1341491484] 'agreement among raft nodes before linearized reading' (duration: 313.903375ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T01:02:12.961272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T01:02:12.64721Z","time spent":"314.048819ms","remote":"127.0.0.1:59506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":30,"request content":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true "} {"level":"info","ts":"2026-10-16T01:02:12.961596Z","caller":"traceutil/trace.go:171","msg":"trace[361281738] linearizableReadLoop","detail":"{readStateIndex:27069; appliedIndex:27067; }","duration":"308.260901ms","start":"2026-10-16T01:02:12.652554Z","end":"2026-10-16T01:02:12.960815Z","steps":["trace[361281738] 'read index received' (duration: 184.208724ms)","trace[361281738] 'applied index is now lower than readState.Index' (duration: 124.051227ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T01:02:13.023964Z","caller":"traceutil/trace.go:171","msg":"trace[606202789] transaction","detail":"{read_only:false; response_revision:26205; number_of_response:1; }","duration":"161.311819ms","start":"2026-10-16T01:02:12.862633Z","end":"2026-10-16T01:02:13.023945Z","steps":["trace[606202789] 'process raft request' (duration: 158.889056ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T01:02:13.024417Z","caller":"traceutil/trace.go:171","msg":"trace[272085428] transaction","detail":"{read_only:false; response_revision:26206; number_of_response:1; }","duration":"153.014505ms","start":"2026-10-16T01:02:12.871391Z","end":"2026-10-16T01:02:13.024406Z","steps":["trace[272085428] 'process raft request' (duration: 152.517565ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T01:02:13.025188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.089898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-10-16T01:02:13.02528Z","caller":"traceutil/trace.go:171","msg":"trace[1492480963] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26206; }","duration":"260.293052ms","start":"2026-10-16T01:02:12.764968Z","end":"2026-10-16T01:02:13.025261Z","steps":["trace[1492480963] 'agreement among raft nodes before linearized reading' (duration: 259.990686ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T01:03:15.364426Z","caller":"traceutil/trace.go:171","msg":"trace[199579765] transaction","detail":"{read_only:false; response_revision:26765; number_of_response:1; }","duration":"169.379418ms","start":"2026-10-16T01:03:15.194834Z","end":"2026-10-16T01:03:15.364214Z","steps":["trace[199579765] 'process raft request' (duration: 169.184173ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T01:03:15.5689Z","caller":"traceutil/trace.go:171","msg":"trace[1844116537] transaction","detail":"{read_only:false; response_revision:26766; number_of_response:1; }","duration":"372.597221ms","start":"2026-10-16T01:03:15.196263Z","end":"2026-10-16T01:03:15.56886Z","steps":["trace[1844116537] 'process raft request' (duration: 372.045039ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T01:03:15.569091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T01:03:15.196239Z","time spent":"372.731524ms","remote":"127.0.0.1:39558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T01:03:15.569383Z","caller":"traceutil/trace.go:171","msg":"trace[2128355791] transaction","detail":"{read_only:false; response_revision:26767; number_of_response:1; }","duration":"368.033101ms","start":"2026-10-16T01:03:15.201316Z","end":"2026-10-16T01:03:15.569349Z","steps":["trace[2128355791] 'process raft request' (duration: 367.460908ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T01:03:15.569538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T01:03:15.201292Z","time spent":"368.164293ms","remote":"127.0.0.1:39558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T01:03:15.569795Z","caller":"traceutil/trace.go:171","msg":"trace[1660436828] transaction","detail":"{read_only:false; response_revision:26768; number_of_response:1; }","duration":"338.728354ms","start":"2026-10-16T01:03:15.231033Z","end":"2026-10-16T01:03:15.569761Z","steps":["trace[1660436828] 'process raft request' (duration: 338.225233ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T01:03:15.569931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T01:03:15.23101Z","time spent":"338.849376ms","remote":"127.0.0.1:39558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T01:03:15.570184Z","caller":"traceutil/trace.go:171","msg":"trace[1151482200] transaction","detail":"{read_only:false; response_revision:26769; number_of_response:1; }","duration":"296.213576ms","start":"2026-10-16T01:03:15.273953Z","end":"2026-10-16T01:03:15.570166Z","steps":["trace[1151482200] 'process raft request' (duration: 295.732385ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T01:03:15.57038Z","caller":"traceutil/trace.go:171","msg":"trace[231451898] transaction","detail":"{read_only:false; response_revision:26771; number_of_response:1; }","duration":"287.364131ms","start":"2026-10-16T01:03:15.282988Z","end":"2026-10-16T01:03:15.570352Z","steps":["trace[231451898] 'process raft request' (duration: 287.260708ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T01:03:15.570382Z","caller":"traceutil/trace.go:171","msg":"trace[1876587815] transaction","detail":"{read_only:false; response_revision:26770; number_of_response:1; }","duration":"294.113929ms","start":"2026-10-16T01:03:15.276225Z","end":"2026-10-16T01:03:15.570339Z","steps":["trace[1876587815] 'process raft request' (duration: 293.902465ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T01:03:15.944308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.431409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11795"} {"level":"info","ts":"2026-10-16T01:03:15.944394Z","caller":"traceutil/trace.go:171","msg":"trace[1254795057] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:26772; }","duration":"155.569632ms","start":"2026-10-16T01:03:15.788805Z","end":"2026-10-16T01:03:15.944375Z","steps":["trace[1254795057] 'range keys from in-memory index tree' (duration: 155.202745ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T01:03:15.944409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.129639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"warn","ts":"2026-10-16T01:03:15.944356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.680478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-16T01:03:15.944607Z","caller":"traceutil/trace.go:171","msg":"trace[2013546840] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26772; }","duration":"110.362835ms","start":"2026-10-16T01:03:15.834216Z","end":"2026-10-16T01:03:15.944579Z","steps":["trace[2013546840] 'range keys from in-memory index tree' (duration: 109.946945ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T01:03:15.944649Z","caller":"traceutil/trace.go:171","msg":"trace[1500323798] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:26772; }","duration":"264.022465ms","start":"2026-10-16T01:03:15.680595Z","end":"2026-10-16T01:03:15.944618Z","steps":["trace[1500323798] 'count revisions from in-memory index tree' (duration: 263.579475ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T01:03:15.945023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.955283ms","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-16T01:03:15.945122Z","caller":"traceutil/trace.go:171","msg":"trace[6424854] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26772; }","duration":"138.385963ms","start":"2026-10-16T01:03:15.806717Z","end":"2026-10-16T01:03:15.945103Z","steps":["trace[6424854] 'range keys from in-memory index tree' (duration: 137.644377ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T01:03:16.292385Z","caller":"traceutil/trace.go:171","msg":"trace[744278662] linearizableReadLoop","detail":"{readStateIndex:27655; appliedIndex:27653; }","duration":"339.882859ms","start":"2026-10-16T01:03:15.952474Z","end":"2026-10-16T01:03:16.292357Z","steps":["trace[744278662] 'read index received' (duration: 160.42314ms)","trace[744278662] 'applied index is now lower than readState.Index' (duration: 179.458609ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T01:03:16.292453Z","caller":"traceutil/trace.go:171","msg":"trace[471815677] transaction","detail":"{read_only:false; response_revision:26773; number_of_response:1; }","duration":"343.229952ms","start":"2026-10-16T01:03:15.949194Z","end":"2026-10-16T01:03:16.292424Z","steps":["trace[471815677] 'process raft request' (duration: 342.943536ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T01:03:16.292502Z","caller":"traceutil/trace.go:171","msg":"trace[1989208193] transaction","detail":"{read_only:false; response_revision:26774; number_of_response:1; }","duration":"343.293244ms","start":"2026-10-16T01:03:15.949197Z","end":"2026-10-16T01:03:16.29249Z","steps":["trace[1989208193] 'process raft request' (duration: 343.10815ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T01:03:16.292598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T01:03:15.949176Z","time spent":"343.343145ms","remote":"127.0.0.1:39558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T01:03:16.292623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T01:03:15.949176Z","time spent":"343.356126ms","remote":"127.0.0.1:39558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T01:03:16.293031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.516883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11795"} {"level":"info","ts":"2026-10-16T01:03:16.293139Z","caller":"traceutil/trace.go:171","msg":"trace[1837090581] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:26774; }","duration":"340.674687ms","start":"2026-10-16T01:03:15.952447Z","end":"2026-10-16T01:03:16.293122Z","steps":["trace[1837090581] 'agreement among raft nodes before linearized reading' (duration: 340.322019ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T01:03:16.293181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T01:03:15.952433Z","time spent":"340.735658ms","remote":"127.0.0.1:39734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":11819,"request content":"key:\"/registry/deployments/openstack/glance-api\" "} {"level":"warn","ts":"2026-10-16T01:03:16.293632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.642694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-16T01:03:16.293699Z","caller":"traceutil/trace.go:171","msg":"trace[1172888479] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26776; }","duration":"237.752756ms","start":"2026-10-16T01:03:16.055929Z","end":"2026-10-16T01:03:16.293681Z","steps":["trace[1172888479] 'agreement among raft nodes before linearized reading' (duration: 237.640864ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T01:03:16.293696Z","caller":"traceutil/trace.go:171","msg":"trace[77786282] transaction","detail":"{read_only:false; response_revision:26775; number_of_response:1; }","duration":"179.557811ms","start":"2026-10-16T01:03:16.114121Z","end":"2026-10-16T01:03:16.293678Z","steps":["trace[77786282] 'process raft request' (duration: 179.193363ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T01:03:16.293753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.529051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-10-16T01:03:16.293734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.787762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeaturerules/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeaturerules0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-16T01:03:16.293658Z","caller":"traceutil/trace.go:171","msg":"trace[1805429450] transaction","detail":"{read_only:false; response_revision:26776; number_of_response:1; }","duration":"169.51798ms","start":"2026-10-16T01:03:16.124114Z","end":"2026-10-16T01:03:16.293632Z","steps":["trace[1805429450] 'process raft request' (duration: 169.336136ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T01:03:16.293897Z","caller":"traceutil/trace.go:171","msg":"trace[1873357971] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeaturerules/; range_end:/registry/nfd.k8s-sigs.io/nodefeaturerules0; response_count:0; response_revision:26776; }","duration":"144.000997ms","start":"2026-10-16T01:03:16.149869Z","end":"2026-10-16T01:03:16.29387Z","steps":["trace[1873357971] 'agreement among raft nodes before linearized reading' (duration: 143.758442ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T01:03:16.293791Z","caller":"traceutil/trace.go:171","msg":"trace[1923283635] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26776; }","duration":"276.609372ms","start":"2026-10-16T01:03:16.017169Z","end":"2026-10-16T01:03:16.293779Z","steps":["trace[1923283635] 'agreement among raft nodes before linearized reading' (duration: 276.49862ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T01:03:16.29362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.137888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusteridentities/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusteridentities0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-16T01:03:16.294235Z","caller":"traceutil/trace.go:171","msg":"trace[861698199] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusteridentities/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusteridentities0; response_count:0; response_revision:26776; }","duration":"293.800352ms","start":"2026-10-16T01:03:16.000419Z","end":"2026-10-16T01:03:16.294219Z","steps":["trace[861698199] 'agreement among raft nodes before linearized reading' (duration: 293.098636ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T01:04:32.399715Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24542} {"level":"info","ts":"2026-10-16T01:04:32.548113Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24542,"took":"144.071527ms","hash":3030027611,"current-db-size-bytes":54161408,"current-db-size":"54 MB","current-db-size-in-use-bytes":36032512,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-10-16T01:04:32.548169Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3030027611,"revision":24542,"compact-revision":21544} {"level":"info","ts":"2026-10-16T01:07:06.075114Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e3e8b7bea2e3a32b","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-16T01:07:06.084712Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-10-16T01:07:06.084825Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-10-16T01:09:32.405264Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27513} {"level":"info","ts":"2026-10-16T01:09:32.550724Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27513,"took":"140.884227ms","hash":1335254526,"current-db-size-bytes":54161408,"current-db-size":"54 MB","current-db-size-in-use-bytes":34717696,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-10-16T01:09:32.550843Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1335254526,"revision":27513,"compact-revision":24542} {"level":"info","ts":"2026-10-16T01:14:32.412697Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30244} {"level":"info","ts":"2026-10-16T01:14:32.569728Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30244,"took":"150.886639ms","hash":585802834,"current-db-size-bytes":54161408,"current-db-size":"54 MB","current-db-size-in-use-bytes":30638080,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-16T01:14:32.569825Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":585802834,"revision":30244,"compact-revision":27513} {"level":"info","ts":"2026-10-16T01:19:32.419331Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32500} {"level":"info","ts":"2026-10-16T01:19:32.569993Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32500,"took":"145.689104ms","hash":38531670,"current-db-size-bytes":55205888,"current-db-size":"55 MB","current-db-size-in-use-bytes":30236672,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-16T01:19:32.570157Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":38531670,"revision":32500,"compact-revision":30244} {"level":"info","ts":"2026-10-16T01:24:32.430337Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34728} {"level":"info","ts":"2026-10-16T01:24:32.559559Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34728,"took":"124.736952ms","hash":569391154,"current-db-size-bytes":55205888,"current-db-size":"55 MB","current-db-size-in-use-bytes":31817728,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-16T01:24:32.559614Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":569391154,"revision":34728,"compact-revision":32500} {"level":"info","ts":"2026-10-16T01:28:22.177675Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e3e8b7bea2e3a32b","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-16T01:28:22.18474Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-10-16T01:28:22.184819Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-10-16T01:29:32.437608Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37022} {"level":"info","ts":"2026-10-16T01:29:32.590339Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37022,"took":"148.403765ms","hash":132014732,"current-db-size-bytes":55205888,"current-db-size":"55 MB","current-db-size-in-use-bytes":32145408,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-16T01:29:32.590404Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":132014732,"revision":37022,"compact-revision":34728} {"level":"info","ts":"2026-10-16T01:34:32.44601Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39299} {"level":"info","ts":"2026-10-16T01:34:32.580752Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39299,"took":"130.363429ms","hash":4015879756,"current-db-size-bytes":56057856,"current-db-size":"56 MB","current-db-size-in-use-bytes":32137216,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-16T01:34:32.580818Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4015879756,"revision":39299,"compact-revision":37022}