{"level":"warn","ts":"2026-07-08T02:16:01.636062Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-08T02:16:01.636195Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.153:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.153:2380","--initial-cluster=instance=https://199.204.45.153:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.153:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.153: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-07-08T02:16:01.636271Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-08T02:16:01.636287Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.153:2380"]} {"level":"info","ts":"2026-07-08T02:16:01.636307Z","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-07-08T02:16:01.636986Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"]} {"level":"info","ts":"2026-07-08T02:16:01.637069Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.153:2380"],"listen-peer-urls":["https://199.204.45.153:2380"],"advertise-client-urls":["https://199.204.45.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.153: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-07-08T02:16:01.640963Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.680306ms"} {"level":"info","ts":"2026-07-08T02:16:01.646439Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"355195d5aae85944","cluster-id":"e424441517bc0b32"} {"level":"info","ts":"2026-07-08T02:16:01.646525Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=()"} {"level":"info","ts":"2026-07-08T02:16:01.646559Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became follower at term 0"} {"level":"info","ts":"2026-07-08T02:16:01.646578Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 355195d5aae85944 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-08T02:16:01.646588Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became follower at term 1"} {"level":"info","ts":"2026-07-08T02:16:01.646644Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=(3842016702051670340)"} {"level":"warn","ts":"2026-07-08T02:16:01.653474Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-08T02:16:01.655092Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-08T02:16:01.6564Z","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-07-08T02:16:01.658701Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"355195d5aae85944","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-08T02:16:01.658931Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"355195d5aae85944","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-08T02:16:01.659039Z","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-07-08T02:16:01.659164Z","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-07-08T02:16:01.659193Z","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-07-08T02:16:01.660753Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=(3842016702051670340)"} {"level":"info","ts":"2026-07-08T02:16:01.661056Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e424441517bc0b32","local-member-id":"355195d5aae85944","added-peer-id":"355195d5aae85944","added-peer-peer-urls":["https://199.204.45.153:2380"]} {"level":"info","ts":"2026-07-08T02:16:01.664292Z","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-07-08T02:16:01.664387Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.153:2380"} {"level":"info","ts":"2026-07-08T02:16:01.664431Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.153:2380"} {"level":"info","ts":"2026-07-08T02:16:01.66471Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"355195d5aae85944","initial-advertise-peer-urls":["https://199.204.45.153:2380"],"listen-peer-urls":["https://199.204.45.153:2380"],"advertise-client-urls":["https://199.204.45.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-08T02:16:01.664793Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-08T02:16:02.449969Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 is starting a new election at term 1"} {"level":"info","ts":"2026-07-08T02:16:02.450066Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-08T02:16:02.450112Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 received MsgPreVoteResp from 355195d5aae85944 at term 1"} {"level":"info","ts":"2026-07-08T02:16:02.450148Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became candidate at term 2"} {"level":"info","ts":"2026-07-08T02:16:02.450164Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 received MsgVoteResp from 355195d5aae85944 at term 2"} {"level":"info","ts":"2026-07-08T02:16:02.450182Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became leader at term 2"} {"level":"info","ts":"2026-07-08T02:16:02.450198Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 355195d5aae85944 elected leader 355195d5aae85944 at term 2"} {"level":"info","ts":"2026-07-08T02:16:02.451583Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T02:16:02.452693Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"355195d5aae85944","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.153:2379]}","request-path":"/0/members/355195d5aae85944/attributes","cluster-id":"e424441517bc0b32","publish-timeout":"7s"} {"level":"info","ts":"2026-07-08T02:16:02.452709Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-08T02:16:02.452894Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-08T02:16:02.453036Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-08T02:16:02.453084Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-08T02:16:02.455655Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e424441517bc0b32","local-member-id":"355195d5aae85944","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T02:16:02.455742Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T02:16:02.455776Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-08T02:16:02.456516Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-08T02:16:02.456567Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.153:2379"} {"level":"info","ts":"2026-07-08T02:16:28.253645Z","caller":"traceutil/trace.go:171","msg":"trace[1685444789] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"147.726319ms","start":"2026-07-08T02:16:28.105862Z","end":"2026-07-08T02:16:28.253588Z","steps":["trace[1685444789] 'process raft request' (duration: 147.06067ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:16:46.711304Z","caller":"traceutil/trace.go:171","msg":"trace[377021570] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"276.219976ms","start":"2026-07-08T02:16:46.435046Z","end":"2026-07-08T02:16:46.711266Z","steps":["trace[377021570] 'process raft request' (duration: 275.896567ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:16:46.711498Z","caller":"traceutil/trace.go:171","msg":"trace[1473348796] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"264.997091ms","start":"2026-07-08T02:16:46.446467Z","end":"2026-07-08T02:16:46.711464Z","steps":["trace[1473348796] 'process raft request' (duration: 264.689912ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:16:46.785214Z","caller":"traceutil/trace.go:171","msg":"trace[614642946] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"230.303205ms","start":"2026-07-08T02:16:46.554878Z","end":"2026-07-08T02:16:46.785181Z","steps":["trace[614642946] 'process raft request' (duration: 229.723378ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:16:47.121369Z","caller":"traceutil/trace.go:171","msg":"trace[105555898] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"273.668837ms","start":"2026-07-08T02:16:46.847662Z","end":"2026-07-08T02:16:47.121331Z","steps":["trace[105555898] 'process raft request' (duration: 177.795156ms)","trace[105555898] 'compare' (duration: 95.734797ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T02:18:18.553809Z","caller":"traceutil/trace.go:171","msg":"trace[1325722984] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"170.453393ms","start":"2026-07-08T02:18:18.383295Z","end":"2026-07-08T02:18:18.553749Z","steps":["trace[1325722984] 'process raft request' (duration: 170.173915ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:18:18.693063Z","caller":"traceutil/trace.go:171","msg":"trace[673248622] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"134.477563ms","start":"2026-07-08T02:18:18.558545Z","end":"2026-07-08T02:18:18.693022Z","steps":["trace[673248622] 'process raft request' (duration: 69.501329ms)","trace[673248622] 'compare' (duration: 64.833229ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T02:18:19.134529Z","caller":"traceutil/trace.go:171","msg":"trace[79845275] linearizableReadLoop","detail":"{readStateIndex:1948; appliedIndex:1947; }","duration":"146.113163ms","start":"2026-07-08T02:18:18.988389Z","end":"2026-07-08T02:18:19.134502Z","steps":["trace[79845275] 'read index received' (duration: 145.950038ms)","trace[79845275] 'applied index is now lower than readState.Index' (duration: 162.185µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T02:18:19.134576Z","caller":"traceutil/trace.go:171","msg":"trace[41784892] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"173.663384ms","start":"2026-07-08T02:18:18.960891Z","end":"2026-07-08T02:18:19.134554Z","steps":["trace[41784892] 'process raft request' (duration: 173.436788ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:18:19.134799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.37806ms","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-07-08T02:18:19.134932Z","caller":"traceutil/trace.go:171","msg":"trace[621614218] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1877; }","duration":"146.555005ms","start":"2026-07-08T02:18:18.988359Z","end":"2026-07-08T02:18:19.134914Z","steps":["trace[621614218] 'agreement among raft nodes before linearized reading' (duration: 146.270017ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:18:33.064824Z","caller":"traceutil/trace.go:171","msg":"trace[105149061] transaction","detail":"{read_only:false; response_revision:1993; number_of_response:1; }","duration":"100.650416ms","start":"2026-07-08T02:18:32.964147Z","end":"2026-07-08T02:18:33.064797Z","steps":["trace[105149061] 'process raft request' (duration: 100.469371ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:18:37.345001Z","caller":"traceutil/trace.go:171","msg":"trace[1921532938] linearizableReadLoop","detail":"{readStateIndex:2097; appliedIndex:2096; }","duration":"200.021696ms","start":"2026-07-08T02:18:37.144958Z","end":"2026-07-08T02:18:37.34498Z","steps":["trace[1921532938] 'read index received' (duration: 199.918713ms)","trace[1921532938] 'applied index is now lower than readState.Index' (duration: 101.923µs)"],"step_count":2} {"level":"warn","ts":"2026-07-08T02:18:37.345327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.531952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T02:18:37.345398Z","caller":"traceutil/trace.go:171","msg":"trace[1302865333] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2022; }","duration":"150.604194ms","start":"2026-07-08T02:18:37.194769Z","end":"2026-07-08T02:18:37.345373Z","steps":["trace[1302865333] 'agreement among raft nodes before linearized reading' (duration: 150.492011ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:18:37.345541Z","caller":"traceutil/trace.go:171","msg":"trace[825130114] transaction","detail":"{read_only:false; response_revision:2022; number_of_response:1; }","duration":"295.708761ms","start":"2026-07-08T02:18:37.049779Z","end":"2026-07-08T02:18:37.345488Z","steps":["trace[825130114] 'process raft request' (duration: 295.060982ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:18:37.345752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.802069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11985"} {"level":"info","ts":"2026-07-08T02:18:37.345796Z","caller":"traceutil/trace.go:171","msg":"trace[1817894335] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2022; }","duration":"200.892161ms","start":"2026-07-08T02:18:37.144893Z","end":"2026-07-08T02:18:37.345786Z","steps":["trace[1817894335] 'agreement among raft nodes before linearized reading' (duration: 200.769968ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:19:15.891757Z","caller":"traceutil/trace.go:171","msg":"trace[311312354] transaction","detail":"{read_only:false; response_revision:2231; number_of_response:1; }","duration":"186.671944ms","start":"2026-07-08T02:19:15.70506Z","end":"2026-07-08T02:19:15.891732Z","steps":["trace[311312354] 'process raft request' (duration: 186.505439ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:19:16.112897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.813806ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T02:19:16.113295Z","caller":"traceutil/trace.go:171","msg":"trace[852089307] linearizableReadLoop","detail":"{readStateIndex:2319; appliedIndex:2315; }","duration":"218.988919ms","start":"2026-07-08T02:19:15.894281Z","end":"2026-07-08T02:19:16.11327Z","steps":["trace[852089307] 'read index received' (duration: 79.134222ms)","trace[852089307] 'applied index is now lower than readState.Index' (duration: 139.853347ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T02:19:16.11342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.138214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-07-08T02:19:16.113414Z","caller":"traceutil/trace.go:171","msg":"trace[188167344] transaction","detail":"{read_only:false; response_revision:2235; number_of_response:1; }","duration":"332.621496ms","start":"2026-07-08T02:19:15.780754Z","end":"2026-07-08T02:19:16.113376Z","steps":["trace[188167344] 'process raft request' (duration: 332.462351ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:19:16.113471Z","caller":"traceutil/trace.go:171","msg":"trace[798477064] transaction","detail":"{read_only:false; response_revision:2233; number_of_response:1; }","duration":"404.771568ms","start":"2026-07-08T02:19:15.708688Z","end":"2026-07-08T02:19:16.11346Z","steps":["trace[798477064] 'process raft request' (duration: 404.349615ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:19:16.113529Z","caller":"traceutil/trace.go:171","msg":"trace[245497815] transaction","detail":"{read_only:false; response_revision:2232; number_of_response:1; }","duration":"404.781778ms","start":"2026-07-08T02:19:15.708688Z","end":"2026-07-08T02:19:16.11347Z","steps":["trace[245497815] 'process raft request' (duration: 264.403607ms)","trace[245497815] 'compare' (duration: 138.543439ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T02:19:16.113623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:19:15.708667Z","time spent":"404.861181ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T02:19:16.113597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:19:15.780724Z","time spent":"332.76594ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T02:19:16.113477Z","caller":"traceutil/trace.go:171","msg":"trace[1031074551] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:2235; }","duration":"219.255196ms","start":"2026-07-08T02:19:15.894207Z","end":"2026-07-08T02:19:16.113462Z","steps":["trace[1031074551] 'agreement among raft nodes before linearized reading' (duration: 219.150963ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:19:16.113386Z","caller":"traceutil/trace.go:171","msg":"trace[1933164276] transaction","detail":"{read_only:false; response_revision:2234; number_of_response:1; }","duration":"404.591273ms","start":"2026-07-08T02:19:15.708752Z","end":"2026-07-08T02:19:16.113343Z","steps":["trace[1933164276] 'process raft request' (duration: 404.410118ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:19:16.113777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:19:15.708671Z","time spent":"404.983694ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T02:19:16.113834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:19:15.708736Z","time spent":"405.048326ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T02:19:16.130528Z","caller":"traceutil/trace.go:171","msg":"trace[249842007] transaction","detail":"{read_only:false; response_revision:2236; number_of_response:1; }","duration":"169.082013ms","start":"2026-07-08T02:19:15.961404Z","end":"2026-07-08T02:19:16.130486Z","steps":["trace[249842007] 'process raft request' (duration: 168.824465ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:19:16.130583Z","caller":"traceutil/trace.go:171","msg":"trace[509436659] transaction","detail":"{read_only:false; response_revision:2237; number_of_response:1; }","duration":"168.255578ms","start":"2026-07-08T02:19:15.962291Z","end":"2026-07-08T02:19:16.130547Z","steps":["trace[509436659] 'process raft request' (duration: 168.112284ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:19:59.177768Z","caller":"traceutil/trace.go:171","msg":"trace[1739817932] transaction","detail":"{read_only:false; response_revision:2642; number_of_response:1; }","duration":"122.600514ms","start":"2026-07-08T02:19:59.055138Z","end":"2026-07-08T02:19:59.177739Z","steps":["trace[1739817932] 'process raft request' (duration: 122.394708ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:20:33.368977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.738842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"warn","ts":"2026-07-08T02:20:33.368973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.034308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T02:20:33.369037Z","caller":"traceutil/trace.go:171","msg":"trace[2040703808] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2846; }","duration":"221.838065ms","start":"2026-07-08T02:20:33.147187Z","end":"2026-07-08T02:20:33.369025Z","steps":["trace[2040703808] 'range keys from in-memory index tree' (duration: 221.435123ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:20:33.36905Z","caller":"traceutil/trace.go:171","msg":"trace[1597290814] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2846; }","duration":"175.128481ms","start":"2026-07-08T02:20:33.193908Z","end":"2026-07-08T02:20:33.369037Z","steps":["trace[1597290814] 'range keys from in-memory index tree' (duration: 174.912105ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:22:26.519346Z","caller":"traceutil/trace.go:171","msg":"trace[1120982411] transaction","detail":"{read_only:false; response_revision:3450; number_of_response:1; }","duration":"131.392234ms","start":"2026-07-08T02:22:26.387922Z","end":"2026-07-08T02:22:26.519314Z","steps":["trace[1120982411] 'process raft request' (duration: 125.516192ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:22:26.519389Z","caller":"traceutil/trace.go:171","msg":"trace[804825309] transaction","detail":"{read_only:false; response_revision:3451; number_of_response:1; }","duration":"131.337382ms","start":"2026-07-08T02:22:26.388013Z","end":"2026-07-08T02:22:26.519351Z","steps":["trace[804825309] 'process raft request' (duration: 131.150857ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:22:26.519522Z","caller":"traceutil/trace.go:171","msg":"trace[446871664] transaction","detail":"{read_only:false; response_revision:3452; number_of_response:1; }","duration":"131.299982ms","start":"2026-07-08T02:22:26.388213Z","end":"2026-07-08T02:22:26.519513Z","steps":["trace[446871664] 'process raft request' (duration: 131.056815ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:22:26.519365Z","caller":"traceutil/trace.go:171","msg":"trace[792837031] transaction","detail":"{read_only:false; response_revision:3453; number_of_response:1; }","duration":"130.929891ms","start":"2026-07-08T02:22:26.388414Z","end":"2026-07-08T02:22:26.519343Z","steps":["trace[792837031] 'process raft request' (duration: 130.89334ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:24:38.713979Z","caller":"traceutil/trace.go:171","msg":"trace[218934676] linearizableReadLoop","detail":"{readStateIndex:5244; appliedIndex:5243; }","duration":"227.975912ms","start":"2026-07-08T02:24:38.485985Z","end":"2026-07-08T02:24:38.713961Z","steps":["trace[218934676] 'read index received' (duration: 227.874599ms)","trace[218934676] 'applied index is now lower than readState.Index' (duration: 100.733µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T02:24:38.714305Z","caller":"traceutil/trace.go:171","msg":"trace[877115256] transaction","detail":"{read_only:false; response_revision:5057; number_of_response:1; }","duration":"229.529017ms","start":"2026-07-08T02:24:38.484738Z","end":"2026-07-08T02:24:38.714267Z","steps":["trace[877115256] 'process raft request' (duration: 228.851888ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:24:38.714421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.413644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-prometheus-node-exporter-zpzw4-tls\" ","response":"range_response_count:1 size:4432"} {"level":"info","ts":"2026-07-08T02:24:38.714484Z","caller":"traceutil/trace.go:171","msg":"trace[1794690567] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-prometheus-node-exporter-zpzw4-tls; range_end:; response_count:1; response_revision:5057; }","duration":"228.515688ms","start":"2026-07-08T02:24:38.485955Z","end":"2026-07-08T02:24:38.714471Z","steps":["trace[1794690567] 'agreement among raft nodes before linearized reading' (duration: 228.317262ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:24:38.725841Z","caller":"traceutil/trace.go:171","msg":"trace[570442687] transaction","detail":"{read_only:false; response_revision:5058; number_of_response:1; }","duration":"156.133351ms","start":"2026-07-08T02:24:38.569683Z","end":"2026-07-08T02:24:38.725817Z","steps":["trace[570442687] 'process raft request' (duration: 155.934875ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:24:38.725835Z","caller":"traceutil/trace.go:171","msg":"trace[1500420453] transaction","detail":"{read_only:false; number_of_response:0; response_revision:5057; }","duration":"234.946962ms","start":"2026-07-08T02:24:38.490852Z","end":"2026-07-08T02:24:38.725799Z","steps":["trace[1500420453] 'process raft request' (duration: 234.681724ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:24:38.72582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.010185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-fkjz2\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-07-08T02:24:38.725966Z","caller":"traceutil/trace.go:171","msg":"trace[2040928420] range","detail":"{range_begin:/registry/pods/openstack/keepalived-fkjz2; range_end:; response_count:1; response_revision:5058; }","duration":"234.20395ms","start":"2026-07-08T02:24:38.491748Z","end":"2026-07-08T02:24:38.725952Z","steps":["trace[2040928420] 'agreement among raft nodes before linearized reading' (duration: 233.948773ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:24:52.055688Z","caller":"traceutil/trace.go:171","msg":"trace[616338845] transaction","detail":"{read_only:false; response_revision:5327; number_of_response:1; }","duration":"103.864464ms","start":"2026-07-08T02:24:51.951786Z","end":"2026-07-08T02:24:52.05565Z","steps":["trace[616338845] 'process raft request' (duration: 64.988043ms)","trace[616338845] 'compare' (duration: 38.717316ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T02:24:52.77005Z","caller":"traceutil/trace.go:171","msg":"trace[576427372] linearizableReadLoop","detail":"{readStateIndex:5531; appliedIndex:5530; }","duration":"149.615093ms","start":"2026-07-08T02:24:52.620414Z","end":"2026-07-08T02:24:52.770029Z","steps":["trace[576427372] 'read index received' (duration: 149.448688ms)","trace[576427372] 'applied index is now lower than readState.Index' (duration: 165.885µs)"],"step_count":2} {"level":"warn","ts":"2026-07-08T02:24:52.770265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.804148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-07-08T02:24:52.7703Z","caller":"traceutil/trace.go:171","msg":"trace[966441116] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:5334; }","duration":"149.915541ms","start":"2026-07-08T02:24:52.620374Z","end":"2026-07-08T02:24:52.77029Z","steps":["trace[966441116] 'agreement among raft nodes before linearized reading' (duration: 149.741206ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:24:52.770651Z","caller":"traceutil/trace.go:171","msg":"trace[1976548750] transaction","detail":"{read_only:false; response_revision:5334; number_of_response:1; }","duration":"155.41684ms","start":"2026-07-08T02:24:52.615225Z","end":"2026-07-08T02:24:52.770642Z","steps":["trace[1976548750] 'process raft request' (duration: 154.688638ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:25:12.563908Z","caller":"traceutil/trace.go:171","msg":"trace[1646593689] transaction","detail":"{read_only:false; response_revision:5657; number_of_response:1; }","duration":"106.476895ms","start":"2026-07-08T02:25:12.457404Z","end":"2026-07-08T02:25:12.563881Z","steps":["trace[1646593689] 'process raft request' (duration: 102.365877ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:26:02.479864Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3004} {"level":"info","ts":"2026-07-08T02:26:02.565068Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3004,"took":"83.723953ms","hash":494301072,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":31531008,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-07-08T02:26:02.565157Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":494301072,"revision":3004,"compact-revision":-1} {"level":"info","ts":"2026-07-08T02:31:02.487415Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6082} {"level":"info","ts":"2026-07-08T02:31:02.587913Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6082,"took":"97.734101ms","hash":1376053612,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":23977984,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-07-08T02:31:02.587973Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1376053612,"revision":6082,"compact-revision":3004} {"level":"info","ts":"2026-07-08T02:31:05.704772Z","caller":"traceutil/trace.go:171","msg":"trace[786272847] linearizableReadLoop","detail":"{readStateIndex:8614; appliedIndex:8613; }","duration":"193.190785ms","start":"2026-07-08T02:31:05.511557Z","end":"2026-07-08T02:31:05.704748Z","steps":["trace[786272847] 'read index received' (duration: 193.01329ms)","trace[786272847] 'applied index is now lower than readState.Index' (duration: 176.315µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T02:31:05.704847Z","caller":"traceutil/trace.go:171","msg":"trace[467202618] transaction","detail":"{read_only:false; response_revision:8325; number_of_response:1; }","duration":"252.523865ms","start":"2026-07-08T02:31:05.452278Z","end":"2026-07-08T02:31:05.704802Z","steps":["trace[467202618] 'process raft request' (duration: 252.314059ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:31:05.704985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.406551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-08T02:31:05.705023Z","caller":"traceutil/trace.go:171","msg":"trace[1601119730] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:8325; }","duration":"193.492034ms","start":"2026-07-08T02:31:05.511521Z","end":"2026-07-08T02:31:05.705013Z","steps":["trace[1601119730] 'agreement among raft nodes before linearized reading' (duration: 193.3373ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:31:17.349547Z","caller":"traceutil/trace.go:171","msg":"trace[1473923778] transaction","detail":"{read_only:false; response_revision:8387; number_of_response:1; }","duration":"127.758631ms","start":"2026-07-08T02:31:17.221747Z","end":"2026-07-08T02:31:17.349506Z","steps":["trace[1473923778] 'process raft request' (duration: 127.401221ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:31:17.718563Z","caller":"traceutil/trace.go:171","msg":"trace[1455368168] transaction","detail":"{read_only:false; response_revision:8388; number_of_response:1; }","duration":"195.77217ms","start":"2026-07-08T02:31:17.522764Z","end":"2026-07-08T02:31:17.718536Z","steps":["trace[1455368168] 'process raft request' (duration: 195.553073ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:31:46.41251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.963578ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-08T02:31:46.412759Z","caller":"traceutil/trace.go:171","msg":"trace[2000894077] transaction","detail":"{read_only:false; response_revision:8596; number_of_response:1; }","duration":"287.499959ms","start":"2026-07-08T02:31:46.125228Z","end":"2026-07-08T02:31:46.412728Z","steps":["trace[2000894077] 'process raft request' (duration: 18.257993ms)","trace[2000894077] 'compare' (duration: 268.778023ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T02:31:46.413283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.715348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-08T02:31:46.413331Z","caller":"traceutil/trace.go:171","msg":"trace[85549996] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8596; }","duration":"285.822951ms","start":"2026-07-08T02:31:46.127496Z","end":"2026-07-08T02:31:46.413319Z","steps":["trace[85549996] 'agreement among raft nodes before linearized reading' (duration: 285.670186ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:31:46.412603Z","caller":"traceutil/trace.go:171","msg":"trace[67485889] linearizableReadLoop","detail":"{readStateIndex:8897; appliedIndex:8896; }","duration":"285.028928ms","start":"2026-07-08T02:31:46.127561Z","end":"2026-07-08T02:31:46.41259Z","steps":["trace[67485889] 'read index received' (duration: 15.866514ms)","trace[67485889] 'applied index is now lower than readState.Index' (duration: 269.161344ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T02:31:46.414086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.620392ms","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-07-08T02:31:46.41408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.668467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T02:31:46.414127Z","caller":"traceutil/trace.go:171","msg":"trace[802886281] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8596; }","duration":"280.680183ms","start":"2026-07-08T02:31:46.133438Z","end":"2026-07-08T02:31:46.414118Z","steps":["trace[802886281] 'agreement among raft nodes before linearized reading' (duration: 280.379565ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:31:46.41415Z","caller":"traceutil/trace.go:171","msg":"trace[1921975374] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8596; }","duration":"219.738629ms","start":"2026-07-08T02:31:46.19439Z","end":"2026-07-08T02:31:46.414129Z","steps":["trace[1921975374] 'agreement among raft nodes before linearized reading' (duration: 219.600475ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:31:46.640944Z","caller":"traceutil/trace.go:171","msg":"trace[1113768370] transaction","detail":"{read_only:false; response_revision:8597; number_of_response:1; }","duration":"223.538348ms","start":"2026-07-08T02:31:46.417388Z","end":"2026-07-08T02:31:46.640927Z","steps":["trace[1113768370] 'process raft request' (duration: 223.387974ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:31:46.641614Z","caller":"traceutil/trace.go:171","msg":"trace[523909511] transaction","detail":"{read_only:false; response_revision:8598; number_of_response:1; }","duration":"222.968041ms","start":"2026-07-08T02:31:46.418626Z","end":"2026-07-08T02:31:46.641594Z","steps":["trace[523909511] 'process raft request' (duration: 222.886839ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:31:50.177644Z","caller":"traceutil/trace.go:171","msg":"trace[1026308887] transaction","detail":"{read_only:false; response_revision:8614; number_of_response:1; }","duration":"108.756133ms","start":"2026-07-08T02:31:50.068853Z","end":"2026-07-08T02:31:50.177609Z","steps":["trace[1026308887] 'process raft request' (duration: 108.441933ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:31:51.06459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.759978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-08T02:31:51.064616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.899057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T02:31:51.06479Z","caller":"traceutil/trace.go:171","msg":"trace[2027705080] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:8616; }","duration":"269.112833ms","start":"2026-07-08T02:31:50.795641Z","end":"2026-07-08T02:31:51.064754Z","steps":["trace[2027705080] 'count revisions from in-memory index tree' (duration: 268.737022ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:31:51.064717Z","caller":"traceutil/trace.go:171","msg":"trace[1612966616] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8616; }","duration":"409.904292ms","start":"2026-07-08T02:31:50.654756Z","end":"2026-07-08T02:31:51.06466Z","steps":["trace[1612966616] 'range keys from in-memory index tree' (duration: 409.565072ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:31:51.065365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:31:50.654735Z","time spent":"410.613513ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-08T02:31:51.064842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.256471ms","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-07-08T02:31:51.065488Z","caller":"traceutil/trace.go:171","msg":"trace[1160087728] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8616; }","duration":"404.92362ms","start":"2026-07-08T02:31:50.660537Z","end":"2026-07-08T02:31:51.06546Z","steps":["trace[1160087728] 'range keys from in-memory index tree' (duration: 404.067366ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:31:51.065536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:31:50.66052Z","time spent":"405.000033ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-08T02:31:51.065598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.555072ms","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-07-08T02:31:51.065672Z","caller":"traceutil/trace.go:171","msg":"trace[192278850] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8616; }","duration":"134.664585ms","start":"2026-07-08T02:31:50.930987Z","end":"2026-07-08T02:31:51.065652Z","steps":["trace[192278850] 'range keys from in-memory index tree' (duration: 134.382876ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:31:51.207586Z","caller":"traceutil/trace.go:171","msg":"trace[2004448541] transaction","detail":"{read_only:false; response_revision:8618; number_of_response:1; }","duration":"136.813856ms","start":"2026-07-08T02:31:51.070747Z","end":"2026-07-08T02:31:51.207561Z","steps":["trace[2004448541] 'process raft request' (duration: 126.338207ms)","trace[2004448541] 'compare' (duration: 10.255163ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T02:31:51.207751Z","caller":"traceutil/trace.go:171","msg":"trace[122197994] transaction","detail":"{read_only:false; response_revision:8619; number_of_response:1; }","duration":"135.860838ms","start":"2026-07-08T02:31:51.071883Z","end":"2026-07-08T02:31:51.207744Z","steps":["trace[122197994] 'process raft request' (duration: 135.593681ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:31:59.215241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.652051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-7jbvm\" ","response":"range_response_count:1 size:4645"} {"level":"info","ts":"2026-07-08T02:31:59.215345Z","caller":"traceutil/trace.go:171","msg":"trace[1420327543] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-7jbvm; range_end:; response_count:1; response_revision:8703; }","duration":"108.769014ms","start":"2026-07-08T02:31:59.106555Z","end":"2026-07-08T02:31:59.215323Z","steps":["trace[1420327543] 'range keys from in-memory index tree' (duration: 108.513446ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:31:59.243126Z","caller":"traceutil/trace.go:171","msg":"trace[1130629369] transaction","detail":"{read_only:false; response_revision:8704; number_of_response:1; }","duration":"136.24233ms","start":"2026-07-08T02:31:59.10686Z","end":"2026-07-08T02:31:59.243102Z","steps":["trace[1130629369] 'process raft request' (duration: 136.033224ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:31:59.404314Z","caller":"traceutil/trace.go:171","msg":"trace[1734466235] linearizableReadLoop","detail":"{readStateIndex:9011; appliedIndex:9010; }","duration":"161.226184ms","start":"2026-07-08T02:31:59.243067Z","end":"2026-07-08T02:31:59.404293Z","steps":["trace[1734466235] 'read index received' (duration: 161.055769ms)","trace[1734466235] 'applied index is now lower than readState.Index' (duration: 169.365µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T02:31:59.404551Z","caller":"traceutil/trace.go:171","msg":"trace[1221996275] transaction","detail":"{read_only:false; response_revision:8705; number_of_response:1; }","duration":"181.35595ms","start":"2026-07-08T02:31:59.223185Z","end":"2026-07-08T02:31:59.404541Z","steps":["trace[1221996275] 'process raft request' (duration: 180.675901ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:31:59.404823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.542437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-08T02:31:59.404923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.824181ms","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-07-08T02:31:59.405012Z","caller":"traceutil/trace.go:171","msg":"trace[974326669] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8705; }","duration":"161.954055ms","start":"2026-07-08T02:31:59.243039Z","end":"2026-07-08T02:31:59.404993Z","steps":["trace[974326669] 'agreement among raft nodes before linearized reading' (duration: 161.667767ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:31:59.405232Z","caller":"traceutil/trace.go:171","msg":"trace[1928429892] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8705; }","duration":"209.778814ms","start":"2026-07-08T02:31:59.195179Z","end":"2026-07-08T02:31:59.404958Z","steps":["trace[1928429892] 'agreement among raft nodes before linearized reading' (duration: 209.534037ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:31:59.41509Z","caller":"traceutil/trace.go:171","msg":"trace[1458128726] transaction","detail":"{read_only:false; response_revision:8706; number_of_response:1; }","duration":"167.444843ms","start":"2026-07-08T02:31:59.247621Z","end":"2026-07-08T02:31:59.415066Z","steps":["trace[1458128726] 'process raft request' (duration: 167.272258ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:31:59.415304Z","caller":"traceutil/trace.go:171","msg":"trace[1477188082] transaction","detail":"{read_only:false; response_revision:8708; number_of_response:1; }","duration":"140.886053ms","start":"2026-07-08T02:31:59.274393Z","end":"2026-07-08T02:31:59.415279Z","steps":["trace[1477188082] 'process raft request' (duration: 140.652066ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:31:59.415102Z","caller":"traceutil/trace.go:171","msg":"trace[2006603945] transaction","detail":"{read_only:false; response_revision:8707; number_of_response:1; }","duration":"148.096339ms","start":"2026-07-08T02:31:59.266987Z","end":"2026-07-08T02:31:59.415084Z","steps":["trace[2006603945] 'process raft request' (duration: 148.011547ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:31:59.415393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.695236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-07-08T02:31:59.415451Z","caller":"traceutil/trace.go:171","msg":"trace[2069686255] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:8708; }","duration":"119.815779ms","start":"2026-07-08T02:31:59.295619Z","end":"2026-07-08T02:31:59.415435Z","steps":["trace[2069686255] 'agreement among raft nodes before linearized reading' (duration: 119.654804ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:31:59.415532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.08946ms","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-07-08T02:31:59.415682Z","caller":"traceutil/trace.go:171","msg":"trace[207086549] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8708; }","duration":"169.277465ms","start":"2026-07-08T02:31:59.246368Z","end":"2026-07-08T02:31:59.415645Z","steps":["trace[207086549] 'agreement among raft nodes before linearized reading' (duration: 168.940575ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:32:00.298788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.434351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T02:32:00.298899Z","caller":"traceutil/trace.go:171","msg":"trace[631308243] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8712; }","duration":"103.606296ms","start":"2026-07-08T02:32:00.195275Z","end":"2026-07-08T02:32:00.298881Z","steps":["trace[631308243] 'range keys from in-memory index tree' (duration: 103.334818ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:32:00.298932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.080091ms","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-07-08T02:32:00.299014Z","caller":"traceutil/trace.go:171","msg":"trace[551271190] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8712; }","duration":"168.282497ms","start":"2026-07-08T02:32:00.130711Z","end":"2026-07-08T02:32:00.298994Z","steps":["trace[551271190] 'range keys from in-memory index tree' (duration: 167.841334ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:32:16.145568Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023cd.wal"} {"level":"warn","ts":"2026-07-08T02:33:07.051363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.499181ms","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-07-08T02:33:07.051506Z","caller":"traceutil/trace.go:171","msg":"trace[1469920375] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:9402; }","duration":"121.737909ms","start":"2026-07-08T02:33:06.929743Z","end":"2026-07-08T02:33:07.051481Z","steps":["trace[1469920375] 'count revisions from in-memory index tree' (duration: 121.385868ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:33:45.874635Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"355195d5aae85944","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-08T02:33:45.880929Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-07-08T02:33:45.881062Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-07-08T02:36:02.495847Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8308} {"level":"info","ts":"2026-07-08T02:36:02.59264Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8308,"took":"94.364553ms","hash":2432735550,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":26660864,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-07-08T02:36:02.592709Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2432735550,"revision":8308,"compact-revision":6082} {"level":"info","ts":"2026-07-08T02:36:43.442419Z","caller":"traceutil/trace.go:171","msg":"trace[1695829841] linearizableReadLoop","detail":"{readStateIndex:11594; appliedIndex:11593; }","duration":"125.472374ms","start":"2026-07-08T02:36:43.316918Z","end":"2026-07-08T02:36:43.44239Z","steps":["trace[1695829841] 'read index received' (duration: 63.684674ms)","trace[1695829841] 'applied index is now lower than readState.Index' (duration: 61.78687ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T02:36:43.442496Z","caller":"traceutil/trace.go:171","msg":"trace[294660322] transaction","detail":"{read_only:false; response_revision:11216; number_of_response:1; }","duration":"136.458222ms","start":"2026-07-08T02:36:43.305995Z","end":"2026-07-08T02:36:43.442453Z","steps":["trace[294660322] 'process raft request' (duration: 74.59678ms)","trace[294660322] 'compare' (duration: 61.635715ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T02:36:43.442551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.617667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-08T02:36:43.442591Z","caller":"traceutil/trace.go:171","msg":"trace[1385281535] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/; range_end:/registry/monitoring.coreos.com/prometheuses0; response_count:0; response_revision:11216; }","duration":"125.72666ms","start":"2026-07-08T02:36:43.316852Z","end":"2026-07-08T02:36:43.442579Z","steps":["trace[1385281535] 'agreement among raft nodes before linearized reading' (duration: 125.637528ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:41:02.506289Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10785} {"level":"info","ts":"2026-07-08T02:41:02.585093Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10785,"took":"76.708682ms","hash":4224698927,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":27160576,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-07-08T02:41:02.585213Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4224698927,"revision":10785,"compact-revision":8308} {"level":"info","ts":"2026-07-08T02:43:39.572192Z","caller":"traceutil/trace.go:171","msg":"trace[1221448641] transaction","detail":"{read_only:false; response_revision:13974; number_of_response:1; }","duration":"325.975959ms","start":"2026-07-08T02:43:39.246195Z","end":"2026-07-08T02:43:39.572171Z","steps":["trace[1221448641] 'process raft request' (duration: 325.831295ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:43:39.572314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:43:39.246134Z","time spent":"326.122003ms","remote":"127.0.0.1:60872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18877,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T02:43:39.577713Z","caller":"traceutil/trace.go:171","msg":"trace[467318155] linearizableReadLoop","detail":"{readStateIndex:14449; appliedIndex:14447; }","duration":"109.49625ms","start":"2026-07-08T02:43:39.468195Z","end":"2026-07-08T02:43:39.577691Z","steps":["trace[467318155] 'read index received' (duration: 103.945351ms)","trace[467318155] 'applied index is now lower than readState.Index' (duration: 5.549839ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T02:43:39.577857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.665945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/openstack/ovn-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-08T02:43:39.577885Z","caller":"traceutil/trace.go:171","msg":"trace[307312762] range","detail":"{range_begin:/registry/daemonsets/openstack/ovn-controller; range_end:; response_count:0; response_revision:13975; }","duration":"109.755147ms","start":"2026-07-08T02:43:39.468121Z","end":"2026-07-08T02:43:39.577876Z","steps":["trace[307312762] 'agreement among raft nodes before linearized reading' (duration: 109.649704ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:43:39.577908Z","caller":"traceutil/trace.go:171","msg":"trace[280861707] transaction","detail":"{read_only:false; response_revision:13975; number_of_response:1; }","duration":"246.13524ms","start":"2026-07-08T02:43:39.331729Z","end":"2026-07-08T02:43:39.577865Z","steps":["trace[280861707] 'process raft request' (duration: 245.659357ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:45:27.871283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.708601ms","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-07-08T02:45:27.871394Z","caller":"traceutil/trace.go:171","msg":"trace[1365853583] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15228; }","duration":"164.874385ms","start":"2026-07-08T02:45:27.706496Z","end":"2026-07-08T02:45:27.871371Z","steps":["trace[1365853583] 'range keys from in-memory index tree' (duration: 164.506545ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:45:27.871377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.492133ms","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-07-08T02:45:27.871458Z","caller":"traceutil/trace.go:171","msg":"trace[849552034] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15228; }","duration":"173.619156ms","start":"2026-07-08T02:45:27.697818Z","end":"2026-07-08T02:45:27.871437Z","steps":["trace[849552034] 'range keys from in-memory index tree' (duration: 173.211375ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:45:28.07215Z","caller":"traceutil/trace.go:171","msg":"trace[1815108398] transaction","detail":"{read_only:false; response_revision:15229; number_of_response:1; }","duration":"195.402561ms","start":"2026-07-08T02:45:27.876715Z","end":"2026-07-08T02:45:28.072118Z","steps":["trace[1815108398] 'process raft request' (duration: 195.172234ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:46:02.513217Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12872} {"level":"info","ts":"2026-07-08T02:46:02.590795Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12872,"took":"74.582598ms","hash":830539759,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":30494720,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-07-08T02:46:02.590851Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":830539759,"revision":12872,"compact-revision":10785} {"level":"info","ts":"2026-07-08T02:51:02.523301Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15441} {"level":"info","ts":"2026-07-08T02:51:02.613635Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15441,"took":"87.792835ms","hash":1892015428,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":32161792,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-07-08T02:51:02.613709Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1892015428,"revision":15441,"compact-revision":12872} {"level":"info","ts":"2026-07-08T02:51:06.818295Z","caller":"traceutil/trace.go:171","msg":"trace[1326293972] transaction","detail":"{read_only:false; response_revision:17824; number_of_response:1; }","duration":"162.06409ms","start":"2026-07-08T02:51:06.656209Z","end":"2026-07-08T02:51:06.818273Z","steps":["trace[1326293972] 'process raft request' (duration: 161.928966ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:51:06.86028Z","caller":"traceutil/trace.go:171","msg":"trace[1502330752] linearizableReadLoop","detail":"{readStateIndex:18423; appliedIndex:18422; }","duration":"147.541384ms","start":"2026-07-08T02:51:06.712705Z","end":"2026-07-08T02:51:06.860246Z","steps":["trace[1502330752] 'read index received' (duration: 105.574643ms)","trace[1502330752] 'applied index is now lower than readState.Index' (duration: 41.965701ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T02:51:06.860435Z","caller":"traceutil/trace.go:171","msg":"trace[1608598068] transaction","detail":"{read_only:false; response_revision:17825; number_of_response:1; }","duration":"179.414936ms","start":"2026-07-08T02:51:06.680974Z","end":"2026-07-08T02:51:06.860389Z","steps":["trace[1608598068] 'process raft request' (duration: 161.503423ms)","trace[1608598068] 'compare' (duration: 17.643026ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T02:51:06.860489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.75941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T02:51:06.860558Z","caller":"traceutil/trace.go:171","msg":"trace[1062596896] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:17825; }","duration":"147.880763ms","start":"2026-07-08T02:51:06.712657Z","end":"2026-07-08T02:51:06.860538Z","steps":["trace[1062596896] 'agreement among raft nodes before linearized reading' (duration: 147.722709ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:51:10.408988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.838458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-07-08T02:51:10.409054Z","caller":"traceutil/trace.go:171","msg":"trace[553047257] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:17850; }","duration":"128.937211ms","start":"2026-07-08T02:51:10.280101Z","end":"2026-07-08T02:51:10.409038Z","steps":["trace[553047257] 'range keys from in-memory index tree' (duration: 128.709205ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:51:10.535973Z","caller":"traceutil/trace.go:171","msg":"trace[1192979394] transaction","detail":"{read_only:false; response_revision:17852; number_of_response:1; }","duration":"111.189263ms","start":"2026-07-08T02:51:10.424756Z","end":"2026-07-08T02:51:10.535945Z","steps":["trace[1192979394] 'process raft request' (duration: 105.13468ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:51:10.963691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.479756ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-08T02:51:10.963761Z","caller":"traceutil/trace.go:171","msg":"trace[1689010385] linearizableReadLoop","detail":"{readStateIndex:18451; appliedIndex:18450; }","duration":"346.985084ms","start":"2026-07-08T02:51:10.616766Z","end":"2026-07-08T02:51:10.963751Z","steps":["trace[1689010385] 'read index received' (duration: 209.369403ms)","trace[1689010385] 'applied index is now lower than readState.Index' (duration: 137.615061ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T02:51:10.963902Z","caller":"traceutil/trace.go:171","msg":"trace[1960162338] transaction","detail":"{read_only:false; response_revision:17853; number_of_response:1; }","duration":"355.143638ms","start":"2026-07-08T02:51:10.608729Z","end":"2026-07-08T02:51:10.963872Z","steps":["trace[1960162338] 'process raft request' (duration: 217.427654ms)","trace[1960162338] 'compare' (duration: 137.307781ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T02:51:10.964034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:51:10.608708Z","time spent":"355.252921ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T02:51:10.964155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.403976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-pqsvs\" ","response":"range_response_count:1 size:9800"} {"level":"info","ts":"2026-07-08T02:51:10.964184Z","caller":"traceutil/trace.go:171","msg":"trace[422591974] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-pqsvs; range_end:; response_count:1; response_revision:17853; }","duration":"347.486388ms","start":"2026-07-08T02:51:10.616689Z","end":"2026-07-08T02:51:10.964176Z","steps":["trace[422591974] 'agreement among raft nodes before linearized reading' (duration: 347.087337ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:51:10.964272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:51:10.616673Z","time spent":"347.591372ms","remote":"127.0.0.1:60876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":9823,"request content":"key:\"/registry/pods/openstack/nova-cell-setup-pqsvs\" "} {"level":"info","ts":"2026-07-08T02:51:11.047549Z","caller":"traceutil/trace.go:171","msg":"trace[813380210] transaction","detail":"{read_only:false; response_revision:17854; number_of_response:1; }","duration":"172.153568ms","start":"2026-07-08T02:51:10.875367Z","end":"2026-07-08T02:51:11.04752Z","steps":["trace[813380210] 'process raft request' (duration: 171.614313ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:54:21.747751Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"355195d5aae85944","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-08T02:54:21.753993Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-07-08T02:54:21.754138Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-07-08T02:56:02.529997Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17762} {"level":"info","ts":"2026-07-08T02:56:02.62752Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17762,"took":"93.544736ms","hash":2651930446,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":34349056,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-07-08T02:56:02.627611Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2651930446,"revision":17762,"compact-revision":15441} {"level":"info","ts":"2026-07-08T02:56:40.367411Z","caller":"traceutil/trace.go:171","msg":"trace[340503129] transaction","detail":"{read_only:false; response_revision:20362; number_of_response:1; }","duration":"133.830681ms","start":"2026-07-08T02:56:40.23355Z","end":"2026-07-08T02:56:40.367381Z","steps":["trace[340503129] 'process raft request' (duration: 133.573723ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:56:46.508943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.323902ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-08T02:56:46.509107Z","caller":"traceutil/trace.go:171","msg":"trace[54489671] transaction","detail":"{read_only:false; response_revision:20397; number_of_response:1; }","duration":"117.483594ms","start":"2026-07-08T02:56:46.391607Z","end":"2026-07-08T02:56:46.50909Z","steps":["trace[54489671] 'process raft request' (duration: 117.430212ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:56:46.509245Z","caller":"traceutil/trace.go:171","msg":"trace[1278316201] transaction","detail":"{read_only:false; response_revision:20396; number_of_response:1; }","duration":"275.529919ms","start":"2026-07-08T02:56:46.233675Z","end":"2026-07-08T02:56:46.509205Z","steps":["trace[1278316201] 'process raft request' (duration: 173.857658ms)","trace[1278316201] 'compare' (duration: 101.229939ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T02:56:46.509435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.495534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:423"} {"level":"info","ts":"2026-07-08T02:56:46.509465Z","caller":"traceutil/trace.go:171","msg":"trace[596268661] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:20397; }","duration":"242.553514ms","start":"2026-07-08T02:56:46.266905Z","end":"2026-07-08T02:56:46.509459Z","steps":["trace[596268661] 'agreement among raft nodes before linearized reading' (duration: 242.40395ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:56:46.509294Z","caller":"traceutil/trace.go:171","msg":"trace[2070368832] linearizableReadLoop","detail":"{readStateIndex:21082; appliedIndex:21081; }","duration":"242.338549ms","start":"2026-07-08T02:56:46.266947Z","end":"2026-07-08T02:56:46.509286Z","steps":["trace[2070368832] 'read index received' (duration: 140.600635ms)","trace[2070368832] 'applied index is now lower than readState.Index' (duration: 101.737053ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T02:56:46.843937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.264795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-08T02:56:46.844021Z","caller":"traceutil/trace.go:171","msg":"trace[622836428] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:20397; }","duration":"104.393359ms","start":"2026-07-08T02:56:46.739605Z","end":"2026-07-08T02:56:46.843999Z","steps":["trace[622836428] 'count revisions from in-memory index tree' (duration: 104.184133ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:56:47.040018Z","caller":"traceutil/trace.go:171","msg":"trace[726990435] transaction","detail":"{read_only:false; response_revision:20399; number_of_response:1; }","duration":"148.123791ms","start":"2026-07-08T02:56:46.891851Z","end":"2026-07-08T02:56:47.039975Z","steps":["trace[726990435] 'process raft request' (duration: 148.000377ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T02:56:47.305108Z","caller":"traceutil/trace.go:171","msg":"trace[1759734735] linearizableReadLoop","detail":"{readStateIndex:21086; appliedIndex:21085; }","duration":"205.609698ms","start":"2026-07-08T02:56:47.099479Z","end":"2026-07-08T02:56:47.305089Z","steps":["trace[1759734735] 'read index received' (duration: 205.384491ms)","trace[1759734735] 'applied index is now lower than readState.Index' (duration: 224.117µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T02:56:47.305199Z","caller":"traceutil/trace.go:171","msg":"trace[173639364] transaction","detail":"{read_only:false; response_revision:20400; number_of_response:1; }","duration":"308.569965ms","start":"2026-07-08T02:56:46.996621Z","end":"2026-07-08T02:56:47.305191Z","steps":["trace[173639364] 'process raft request' (duration: 308.299307ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:56:47.305275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T02:56:46.996598Z","time spent":"308.618686ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T02:56:47.305453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.337613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-07-08T02:56:47.305496Z","caller":"traceutil/trace.go:171","msg":"trace[1538986601] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20400; }","duration":"195.401805ms","start":"2026-07-08T02:56:47.110083Z","end":"2026-07-08T02:56:47.305485Z","steps":["trace[1538986601] 'agreement among raft nodes before linearized reading' (duration: 195.243001ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:56:47.305537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.05776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-08T02:56:47.305563Z","caller":"traceutil/trace.go:171","msg":"trace[1937758328] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20400; }","duration":"206.126162ms","start":"2026-07-08T02:56:47.099429Z","end":"2026-07-08T02:56:47.305555Z","steps":["trace[1937758328] 'agreement among raft nodes before linearized reading' (duration: 206.0548ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:56:47.305639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.98035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T02:56:47.305668Z","caller":"traceutil/trace.go:171","msg":"trace[958609271] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20400; }","duration":"109.052553ms","start":"2026-07-08T02:56:47.196609Z","end":"2026-07-08T02:56:47.305662Z","steps":["trace[958609271] 'agreement among raft nodes before linearized reading' (duration: 109.009112ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T02:56:47.617326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.951972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-07-08T02:56:47.617484Z","caller":"traceutil/trace.go:171","msg":"trace[1148859795] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:20402; }","duration":"231.177579ms","start":"2026-07-08T02:56:47.386285Z","end":"2026-07-08T02:56:47.617463Z","steps":["trace[1148859795] 'range keys from in-memory index tree' (duration: 230.766717ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:00:48.073094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.804021ms","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-07-08T03:00:48.073184Z","caller":"traceutil/trace.go:171","msg":"trace[1635716388] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:22938; }","duration":"245.938124ms","start":"2026-07-08T03:00:47.827227Z","end":"2026-07-08T03:00:48.073165Z","steps":["trace[1635716388] 'range keys from in-memory index tree' (duration: 245.740148ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:00:48.074365Z","caller":"traceutil/trace.go:171","msg":"trace[1529859228] transaction","detail":"{read_only:false; response_revision:22939; number_of_response:1; }","duration":"153.010852ms","start":"2026-07-08T03:00:47.921331Z","end":"2026-07-08T03:00:48.074342Z","steps":["trace[1529859228] 'process raft request' (duration: 151.324024ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:00:48.074398Z","caller":"traceutil/trace.go:171","msg":"trace[289184123] transaction","detail":"{read_only:false; response_revision:22940; number_of_response:1; }","duration":"103.017601ms","start":"2026-07-08T03:00:47.971353Z","end":"2026-07-08T03:00:48.074371Z","steps":["trace[289184123] 'process raft request' (duration: 102.853726ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:01:02.537726Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20170} {"level":"info","ts":"2026-07-08T03:01:02.643759Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20170,"took":"102.098894ms","hash":3361024178,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":42655744,"current-db-size-in-use":"43 MB"} {"level":"info","ts":"2026-07-08T03:01:02.643856Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3361024178,"revision":20170,"compact-revision":17762} {"level":"info","ts":"2026-07-08T03:04:13.529726Z","caller":"traceutil/trace.go:171","msg":"trace[613110086] linearizableReadLoop","detail":"{readStateIndex:25820; appliedIndex:25819; }","duration":"113.770859ms","start":"2026-07-08T03:04:13.415921Z","end":"2026-07-08T03:04:13.529692Z","steps":["trace[613110086] 'read index received' (duration: 113.568873ms)","trace[613110086] 'applied index is now lower than readState.Index' (duration: 200.246µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:04:13.529846Z","caller":"traceutil/trace.go:171","msg":"trace[1772913771] transaction","detail":"{read_only:false; response_revision:25006; number_of_response:1; }","duration":"131.189937ms","start":"2026-07-08T03:04:13.398613Z","end":"2026-07-08T03:04:13.529803Z","steps":["trace[1772913771] 'process raft request' (duration: 130.811256ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:13.529939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.882355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T03:04:13.529985Z","caller":"traceutil/trace.go:171","msg":"trace[1178525573] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0; response_count:0; response_revision:25006; }","duration":"103.982948ms","start":"2026-07-08T03:04:13.425989Z","end":"2026-07-08T03:04:13.529972Z","steps":["trace[1178525573] 'agreement among raft nodes before linearized reading' (duration: 103.877575ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:13.529995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.021876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-08T03:04:13.530121Z","caller":"traceutil/trace.go:171","msg":"trace[1384558963] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/; range_end:/registry/monitoring.coreos.com/prometheuses0; response_count:0; response_revision:25006; }","duration":"114.214811ms","start":"2026-07-08T03:04:13.41588Z","end":"2026-07-08T03:04:13.530095Z","steps":["trace[1384558963] 'agreement among raft nodes before linearized reading' (duration: 113.956414ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:13.875162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.054673ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-08T03:04:13.87546Z","caller":"traceutil/trace.go:171","msg":"trace[987662884] linearizableReadLoop","detail":"{readStateIndex:25822; appliedIndex:25820; }","duration":"280.120243ms","start":"2026-07-08T03:04:13.595318Z","end":"2026-07-08T03:04:13.875439Z","steps":["trace[987662884] 'read index received' (duration: 22.707771ms)","trace[987662884] 'applied index is now lower than readState.Index' (duration: 257.410942ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:04:13.875574Z","caller":"traceutil/trace.go:171","msg":"trace[1769041445] transaction","detail":"{read_only:false; response_revision:25007; number_of_response:1; }","duration":"340.42378ms","start":"2026-07-08T03:04:13.535133Z","end":"2026-07-08T03:04:13.875557Z","steps":["trace[1769041445] 'process raft request' (duration: 82.874543ms)","trace[1769041445] 'compare' (duration: 256.674082ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:04:13.875667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:04:13.535109Z","time spent":"340.511532ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T03:04:13.87587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.779977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" ","response":"range_response_count:1 size:215"} {"level":"info","ts":"2026-07-08T03:04:13.875893Z","caller":"traceutil/trace.go:171","msg":"trace[635679249] transaction","detail":"{read_only:false; response_revision:25009; number_of_response:1; }","duration":"237.43692ms","start":"2026-07-08T03:04:13.63844Z","end":"2026-07-08T03:04:13.875876Z","steps":["trace[635679249] 'process raft request' (duration: 237.271865ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:13.875642Z","caller":"traceutil/trace.go:171","msg":"trace[748023392] transaction","detail":"{read_only:false; response_revision:25008; number_of_response:1; }","duration":"319.513441ms","start":"2026-07-08T03:04:13.556092Z","end":"2026-07-08T03:04:13.875606Z","steps":["trace[748023392] 'process raft request' (duration: 319.209443ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:13.875912Z","caller":"traceutil/trace.go:171","msg":"trace[1456160865] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/resourcequota-controller; range_end:; response_count:1; response_revision:25009; }","duration":"151.85368ms","start":"2026-07-08T03:04:13.724048Z","end":"2026-07-08T03:04:13.875901Z","steps":["trace[1456160865] 'agreement among raft nodes before linearized reading' (duration: 151.717366ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:13.875955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.639388ms","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-07-08T03:04:13.876013Z","caller":"traceutil/trace.go:171","msg":"trace[2076484977] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25009; }","duration":"280.74197ms","start":"2026-07-08T03:04:13.595253Z","end":"2026-07-08T03:04:13.875995Z","steps":["trace[2076484977] 'agreement among raft nodes before linearized reading' (duration: 280.572395ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:13.876026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:04:13.556058Z","time spent":"319.882612ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T03:04:14.028596Z","caller":"traceutil/trace.go:171","msg":"trace[576860183] linearizableReadLoop","detail":"{readStateIndex:25824; appliedIndex:25823; }","duration":"106.717736ms","start":"2026-07-08T03:04:13.921849Z","end":"2026-07-08T03:04:14.028567Z","steps":["trace[576860183] 'read index received' (duration: 88.890595ms)","trace[576860183] 'applied index is now lower than readState.Index' (duration: 17.825911ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:04:14.028798Z","caller":"traceutil/trace.go:171","msg":"trace[1889644035] transaction","detail":"{read_only:false; response_revision:25010; number_of_response:1; }","duration":"145.121356ms","start":"2026-07-08T03:04:13.883659Z","end":"2026-07-08T03:04:14.028781Z","steps":["trace[1889644035] 'process raft request' (duration: 127.139061ms)","trace[1889644035] 'compare' (duration: 17.634786ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:04:14.029181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.324493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-07-08T03:04:14.029267Z","caller":"traceutil/trace.go:171","msg":"trace[2038332035] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25010; }","duration":"107.457968ms","start":"2026-07-08T03:04:13.92179Z","end":"2026-07-08T03:04:14.029248Z","steps":["trace[2038332035] 'agreement among raft nodes before linearized reading' (duration: 107.294683ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:17.442536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.700268ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-08T03:04:17.442622Z","caller":"traceutil/trace.go:171","msg":"trace[678074688] linearizableReadLoop","detail":"{readStateIndex:25855; appliedIndex:25854; }","duration":"206.198305ms","start":"2026-07-08T03:04:17.236413Z","end":"2026-07-08T03:04:17.442611Z","steps":["trace[678074688] 'read index received' (duration: 50.277961ms)","trace[678074688] 'applied index is now lower than readState.Index' (duration: 155.919164ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:04:17.442815Z","caller":"traceutil/trace.go:171","msg":"trace[39070984] transaction","detail":"{read_only:false; response_revision:25040; number_of_response:1; }","duration":"230.086171ms","start":"2026-07-08T03:04:17.212707Z","end":"2026-07-08T03:04:17.442793Z","steps":["trace[39070984] 'process raft request' (duration: 74.063632ms)","trace[39070984] 'compare' (duration: 155.140003ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:04:17.442866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.432953ms","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-07-08T03:04:17.442941Z","caller":"traceutil/trace.go:171","msg":"trace[1191240134] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25040; }","duration":"206.546436ms","start":"2026-07-08T03:04:17.236379Z","end":"2026-07-08T03:04:17.442925Z","steps":["trace[1191240134] 'agreement among raft nodes before linearized reading' (duration: 206.33217ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:17.724182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.295673ms","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-07-08T03:04:17.724235Z","caller":"traceutil/trace.go:171","msg":"trace[1704524001] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25040; }","duration":"181.395716ms","start":"2026-07-08T03:04:17.542828Z","end":"2026-07-08T03:04:17.724224Z","steps":["trace[1704524001] 'range keys from in-memory index tree' (duration: 181.179369ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:17.724267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.922178ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-08T03:04:17.724328Z","caller":"traceutil/trace.go:171","msg":"trace[2088821803] linearizableReadLoop","detail":"{readStateIndex:25856; appliedIndex:25855; }","duration":"153.855566ms","start":"2026-07-08T03:04:17.570463Z","end":"2026-07-08T03:04:17.724318Z","steps":["trace[2088821803] 'read index received' (duration: 51.735202ms)","trace[2088821803] 'applied index is now lower than readState.Index' (duration: 102.119614ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:04:17.724473Z","caller":"traceutil/trace.go:171","msg":"trace[1699537489] transaction","detail":"{read_only:false; response_revision:25041; number_of_response:1; }","duration":"178.365ms","start":"2026-07-08T03:04:17.546099Z","end":"2026-07-08T03:04:17.724464Z","steps":["trace[1699537489] 'process raft request' (duration: 76.193124ms)","trace[1699537489] 'compare' (duration: 101.844316ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:04:17.724598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.140705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/thanosrulers/\" range_end:\"/registry/monitoring.coreos.com/thanosrulers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T03:04:17.724627Z","caller":"traceutil/trace.go:171","msg":"trace[1168665932] range","detail":"{range_begin:/registry/monitoring.coreos.com/thanosrulers/; range_end:/registry/monitoring.coreos.com/thanosrulers0; response_count:0; response_revision:25041; }","duration":"154.207757ms","start":"2026-07-08T03:04:17.570413Z","end":"2026-07-08T03:04:17.72462Z","steps":["trace[1168665932] 'agreement among raft nodes before linearized reading' (duration: 154.159566ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:18.036648Z","caller":"traceutil/trace.go:171","msg":"trace[409091676] linearizableReadLoop","detail":"{readStateIndex:25857; appliedIndex:25856; }","duration":"148.567005ms","start":"2026-07-08T03:04:17.888066Z","end":"2026-07-08T03:04:18.036633Z","steps":["trace[409091676] 'read index received' (duration: 148.42913ms)","trace[409091676] 'applied index is now lower than readState.Index' (duration: 137.125µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:04:18.0367Z","caller":"traceutil/trace.go:171","msg":"trace[636515253] transaction","detail":"{read_only:false; response_revision:25042; number_of_response:1; }","duration":"149.648066ms","start":"2026-07-08T03:04:17.887027Z","end":"2026-07-08T03:04:18.036676Z","steps":["trace[636515253] 'process raft request' (duration: 149.481771ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:18.036875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.797701ms","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-07-08T03:04:18.036923Z","caller":"traceutil/trace.go:171","msg":"trace[348009714] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25042; }","duration":"148.886665ms","start":"2026-07-08T03:04:17.888024Z","end":"2026-07-08T03:04:18.036911Z","steps":["trace[348009714] 'agreement among raft nodes before linearized reading' (duration: 148.685989ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:18.29499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.496893ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-08T03:04:18.295111Z","caller":"traceutil/trace.go:171","msg":"trace[303300396] linearizableReadLoop","detail":"{readStateIndex:25858; appliedIndex:25857; }","duration":"252.701577ms","start":"2026-07-08T03:04:18.042389Z","end":"2026-07-08T03:04:18.295091Z","steps":["trace[303300396] 'read index received' (duration: 104.000688ms)","trace[303300396] 'applied index is now lower than readState.Index' (duration: 148.699319ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:04:18.295136Z","caller":"traceutil/trace.go:171","msg":"trace[328339945] transaction","detail":"{read_only:false; response_revision:25043; number_of_response:1; }","duration":"253.321586ms","start":"2026-07-08T03:04:18.041801Z","end":"2026-07-08T03:04:18.295123Z","steps":["trace[328339945] 'process raft request' (duration: 104.585196ms)","trace[328339945] 'compare' (duration: 148.39368ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:04:18.295301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.901153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-07-08T03:04:18.29535Z","caller":"traceutil/trace.go:171","msg":"trace[222704541] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25043; }","duration":"252.975515ms","start":"2026-07-08T03:04:18.042361Z","end":"2026-07-08T03:04:18.295336Z","steps":["trace[222704541] 'agreement among raft nodes before linearized reading' (duration: 252.817911ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:18.362208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.835088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-07-08T03:04:18.362229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.323282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T03:04:18.362295Z","caller":"traceutil/trace.go:171","msg":"trace[510396253] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25044; }","duration":"166.959783ms","start":"2026-07-08T03:04:18.195315Z","end":"2026-07-08T03:04:18.362275Z","steps":["trace[510396253] 'agreement among raft nodes before linearized reading' (duration: 166.819579ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:18.362327Z","caller":"traceutil/trace.go:171","msg":"trace[1324458864] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:25044; }","duration":"263.442666ms","start":"2026-07-08T03:04:18.09887Z","end":"2026-07-08T03:04:18.362313Z","steps":["trace[1324458864] 'agreement among raft nodes before linearized reading' (duration: 263.277151ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:18.362435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.234057ms","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-07-08T03:04:18.362438Z","caller":"traceutil/trace.go:171","msg":"trace[283373101] transaction","detail":"{read_only:false; response_revision:25044; number_of_response:1; }","duration":"193.130181ms","start":"2026-07-08T03:04:18.169272Z","end":"2026-07-08T03:04:18.362402Z","steps":["trace[283373101] 'process raft request' (duration: 192.71965ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:18.36248Z","caller":"traceutil/trace.go:171","msg":"trace[1450202724] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25044; }","duration":"316.311209ms","start":"2026-07-08T03:04:18.046158Z","end":"2026-07-08T03:04:18.362469Z","steps":["trace[1450202724] 'agreement among raft nodes before linearized reading' (duration: 316.165525ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:18.36252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.008842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"warn","ts":"2026-07-08T03:04:18.362614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.107361ms","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-07-08T03:04:18.362626Z","caller":"traceutil/trace.go:171","msg":"trace[2133630525] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25044; }","duration":"227.157776ms","start":"2026-07-08T03:04:18.135444Z","end":"2026-07-08T03:04:18.362601Z","steps":["trace[2133630525] 'agreement among raft nodes before linearized reading' (duration: 226.854417ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:18.362644Z","caller":"traceutil/trace.go:171","msg":"trace[55517729] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:25044; }","duration":"318.162403ms","start":"2026-07-08T03:04:18.044474Z","end":"2026-07-08T03:04:18.362636Z","steps":["trace[55517729] 'agreement among raft nodes before linearized reading' (duration: 317.631478ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:18.362637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:04:18.046135Z","time spent":"316.455003ms","remote":"127.0.0.1:60958","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-07-08T03:04:18.362672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:04:18.044463Z","time spent":"318.203894ms","remote":"127.0.0.1:32910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":11818,"request content":"key:\"/registry/deployments/openstack/glance-api\" "} {"level":"info","ts":"2026-07-08T03:04:20.199964Z","caller":"traceutil/trace.go:171","msg":"trace[1332091850] linearizableReadLoop","detail":"{readStateIndex:25872; appliedIndex:25871; }","duration":"150.418559ms","start":"2026-07-08T03:04:20.049529Z","end":"2026-07-08T03:04:20.199948Z","steps":["trace[1332091850] 'read index received' (duration: 150.295615ms)","trace[1332091850] 'applied index is now lower than readState.Index' (duration: 121.994µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:04:20.200051Z","caller":"traceutil/trace.go:171","msg":"trace[1411494683] transaction","detail":"{read_only:false; response_revision:25057; number_of_response:1; }","duration":"155.601617ms","start":"2026-07-08T03:04:20.044418Z","end":"2026-07-08T03:04:20.200019Z","steps":["trace[1411494683] 'process raft request' (duration: 155.417312ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:20.200664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.989135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T03:04:20.200806Z","caller":"traceutil/trace.go:171","msg":"trace[862370819] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:25057; }","duration":"151.239782ms","start":"2026-07-08T03:04:20.049513Z","end":"2026-07-08T03:04:20.200752Z","steps":["trace[862370819] 'agreement among raft nodes before linearized reading' (duration: 150.541172ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:20.540191Z","caller":"traceutil/trace.go:171","msg":"trace[1576852300] transaction","detail":"{read_only:false; response_revision:25058; number_of_response:1; }","duration":"172.675265ms","start":"2026-07-08T03:04:20.367487Z","end":"2026-07-08T03:04:20.540163Z","steps":["trace[1576852300] 'process raft request' (duration: 172.308484ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:20.823078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.370605ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-08T03:04:20.823432Z","caller":"traceutil/trace.go:171","msg":"trace[1465232922] transaction","detail":"{read_only:false; response_revision:25059; number_of_response:1; }","duration":"453.402436ms","start":"2026-07-08T03:04:20.370013Z","end":"2026-07-08T03:04:20.823415Z","steps":["trace[1465232922] 'process raft request' (duration: 272.616869ms)","trace[1465232922] 'compare' (duration: 180.279003ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:04:20.823511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:04:20.369986Z","time spent":"453.487229ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T03:04:20.823171Z","caller":"traceutil/trace.go:171","msg":"trace[2010386915] linearizableReadLoop","detail":"{readStateIndex:25874; appliedIndex:25872; }","duration":"434.33868ms","start":"2026-07-08T03:04:20.388817Z","end":"2026-07-08T03:04:20.823155Z","steps":["trace[2010386915] 'read index received' (duration: 150.939893ms)","trace[2010386915] 'applied index is now lower than readState.Index' (duration: 283.397377ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:04:20.824044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.210676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-07-08T03:04:20.824114Z","caller":"traceutil/trace.go:171","msg":"trace[2011397605] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25059; }","duration":"435.393831ms","start":"2026-07-08T03:04:20.388702Z","end":"2026-07-08T03:04:20.824096Z","steps":["trace[2011397605] 'agreement among raft nodes before linearized reading' (duration: 435.162083ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:20.824169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:04:20.388679Z","time spent":"435.482333ms","remote":"127.0.0.1:60958","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-07-08T03:04:21.11889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.944818ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-08T03:04:21.119064Z","caller":"traceutil/trace.go:171","msg":"trace[218661841] linearizableReadLoop","detail":"{readStateIndex:25876; appliedIndex:25874; }","duration":"294.982618ms","start":"2026-07-08T03:04:20.824067Z","end":"2026-07-08T03:04:21.11905Z","steps":["trace[218661841] 'read index received' (duration: 17.165261ms)","trace[218661841] 'applied index is now lower than readState.Index' (duration: 277.816287ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:04:21.119122Z","caller":"traceutil/trace.go:171","msg":"trace[243980267] transaction","detail":"{read_only:false; response_revision:25061; number_of_response:1; }","duration":"304.193913ms","start":"2026-07-08T03:04:20.814919Z","end":"2026-07-08T03:04:21.119113Z","steps":["trace[243980267] 'process raft request' (duration: 162.962677ms)","trace[243980267] 'compare' (duration: 140.752962ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:04:21.119166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:04:20.814904Z","time spent":"304.238675ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T03:04:21.119252Z","caller":"traceutil/trace.go:171","msg":"trace[1615545088] transaction","detail":"{read_only:false; response_revision:25062; number_of_response:1; }","duration":"284.235812ms","start":"2026-07-08T03:04:20.83501Z","end":"2026-07-08T03:04:21.119246Z","steps":["trace[1615545088] 'process raft request' (duration: 283.964024ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:21.119365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.599745ms","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-07-08T03:04:21.119392Z","caller":"traceutil/trace.go:171","msg":"trace[2000139480] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25062; }","duration":"296.669677ms","start":"2026-07-08T03:04:20.822712Z","end":"2026-07-08T03:04:21.119381Z","steps":["trace[2000139480] 'agreement among raft nodes before linearized reading' (duration: 296.581375ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:21.119454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.727252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T03:04:21.119472Z","caller":"traceutil/trace.go:171","msg":"trace[1547812449] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:25062; }","duration":"359.789334ms","start":"2026-07-08T03:04:20.759675Z","end":"2026-07-08T03:04:21.119465Z","steps":["trace[1547812449] 'agreement among raft nodes before linearized reading' (duration: 359.757563ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:21.119491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:04:20.759654Z","time spent":"359.831615ms","remote":"127.0.0.1:35248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true "} {"level":"warn","ts":"2026-07-08T03:04:21.119524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.219116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-07-08T03:04:21.119536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.106859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-07-08T03:04:21.119538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"691.023082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T03:04:21.119604Z","caller":"traceutil/trace.go:171","msg":"trace[1914061775] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:25062; }","duration":"489.186971ms","start":"2026-07-08T03:04:20.6304Z","end":"2026-07-08T03:04:21.119587Z","steps":["trace[1914061775] 'agreement among raft nodes before linearized reading' (duration: 489.071538ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:21.119619Z","caller":"traceutil/trace.go:171","msg":"trace[352156271] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:25062; }","duration":"691.135776ms","start":"2026-07-08T03:04:20.428464Z","end":"2026-07-08T03:04:21.1196Z","steps":["trace[352156271] 'agreement among raft nodes before linearized reading' (duration: 690.989811ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:21.119624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"726.759985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-07-08T03:04:21.11964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:04:20.630306Z","time spent":"489.325405ms","remote":"127.0.0.1:38470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true "} {"level":"info","ts":"2026-07-08T03:04:21.119678Z","caller":"traceutil/trace.go:171","msg":"trace[429238863] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25062; }","duration":"726.858967ms","start":"2026-07-08T03:04:20.392806Z","end":"2026-07-08T03:04:21.119665Z","steps":["trace[429238863] 'agreement among raft nodes before linearized reading' (duration: 726.698653ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:21.119681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:04:20.428418Z","time spent":"691.246558ms","remote":"127.0.0.1:43504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"info","ts":"2026-07-08T03:04:21.119573Z","caller":"traceutil/trace.go:171","msg":"trace[1741041933] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:25062; }","duration":"479.280657ms","start":"2026-07-08T03:04:20.64028Z","end":"2026-07-08T03:04:21.11956Z","steps":["trace[1741041933] 'agreement among raft nodes before linearized reading' (duration: 479.181565ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:21.119712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:04:20.392785Z","time spent":"726.92072ms","remote":"127.0.0.1:60958","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-07-08T03:04:21.119747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:04:20.64022Z","time spent":"479.521654ms","remote":"127.0.0.1:35250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":29,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "} {"level":"warn","ts":"2026-07-08T03:04:21.119741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"725.290543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-08T03:04:21.119817Z","caller":"traceutil/trace.go:171","msg":"trace[1735551149] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25062; }","duration":"725.385666ms","start":"2026-07-08T03:04:20.394411Z","end":"2026-07-08T03:04:21.119797Z","steps":["trace[1735551149] 'agreement among raft nodes before linearized reading' (duration: 725.058477ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:21.119861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:04:20.394402Z","time spent":"725.450508ms","remote":"127.0.0.1:60958","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":"info","ts":"2026-07-08T03:04:21.26406Z","caller":"traceutil/trace.go:171","msg":"trace[853802549] linearizableReadLoop","detail":"{readStateIndex:25878; appliedIndex:25877; }","duration":"144.944812ms","start":"2026-07-08T03:04:21.119089Z","end":"2026-07-08T03:04:21.264033Z","steps":["trace[853802549] 'read index received' (duration: 144.850799ms)","trace[853802549] 'applied index is now lower than readState.Index' (duration: 92.563µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:04:21.264171Z","caller":"traceutil/trace.go:171","msg":"trace[204462490] transaction","detail":"{read_only:false; response_revision:25063; number_of_response:1; }","duration":"240.841788ms","start":"2026-07-08T03:04:21.023287Z","end":"2026-07-08T03:04:21.264128Z","steps":["trace[204462490] 'process raft request' (duration: 240.55827ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:21.264264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.345411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T03:04:21.264322Z","caller":"traceutil/trace.go:171","msg":"trace[1662666288] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:25063; }","duration":"220.461255ms","start":"2026-07-08T03:04:21.043844Z","end":"2026-07-08T03:04:21.264306Z","steps":["trace[1662666288] 'agreement among raft nodes before linearized reading' (duration: 220.31655ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:21.264553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.904218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"info","ts":"2026-07-08T03:04:21.264654Z","caller":"traceutil/trace.go:171","msg":"trace[805497025] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:25063; }","duration":"176.056043ms","start":"2026-07-08T03:04:21.088574Z","end":"2026-07-08T03:04:21.26463Z","steps":["trace[805497025] 'agreement among raft nodes before linearized reading' (duration: 175.579349ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:21.276651Z","caller":"traceutil/trace.go:171","msg":"trace[925483459] transaction","detail":"{read_only:false; response_revision:25064; number_of_response:1; }","duration":"152.61941ms","start":"2026-07-08T03:04:21.124017Z","end":"2026-07-08T03:04:21.276636Z","steps":["trace[925483459] 'process raft request' (duration: 152.440965ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:21.276716Z","caller":"traceutil/trace.go:171","msg":"trace[46510767] transaction","detail":"{read_only:false; response_revision:25065; number_of_response:1; }","duration":"152.639621ms","start":"2026-07-08T03:04:21.124051Z","end":"2026-07-08T03:04:21.27669Z","steps":["trace[46510767] 'process raft request' (duration: 152.493367ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:21.276749Z","caller":"traceutil/trace.go:171","msg":"trace[1154078191] transaction","detail":"{read_only:false; response_revision:25066; number_of_response:1; }","duration":"152.676952ms","start":"2026-07-08T03:04:21.124057Z","end":"2026-07-08T03:04:21.276734Z","steps":["trace[1154078191] 'process raft request' (duration: 152.512068ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:21.276921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.49913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T03:04:21.277033Z","caller":"traceutil/trace.go:171","msg":"trace[2041034910] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:25068; }","duration":"150.642615ms","start":"2026-07-08T03:04:21.126326Z","end":"2026-07-08T03:04:21.276968Z","steps":["trace[2041034910] 'agreement among raft nodes before linearized reading' (duration: 150.48ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:21.497491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.234824ms","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-07-08T03:04:21.497584Z","caller":"traceutil/trace.go:171","msg":"trace[447530743] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-nova-server-0; range_end:; response_count:1; response_revision:25068; }","duration":"120.363897ms","start":"2026-07-08T03:04:21.377195Z","end":"2026-07-08T03:04:21.497559Z","steps":["trace[447530743] 'range keys from in-memory index tree' (duration: 119.988986ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:21.798486Z","caller":"traceutil/trace.go:171","msg":"trace[1216660999] linearizableReadLoop","detail":"{readStateIndex:25885; appliedIndex:25884; }","duration":"297.273584ms","start":"2026-07-08T03:04:21.501193Z","end":"2026-07-08T03:04:21.798466Z","steps":["trace[1216660999] 'read index received' (duration: 297.13148ms)","trace[1216660999] 'applied index is now lower than readState.Index' (duration: 141.544µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:04:21.798567Z","caller":"traceutil/trace.go:171","msg":"trace[1338269439] transaction","detail":"{read_only:false; response_revision:25069; number_of_response:1; }","duration":"343.19997ms","start":"2026-07-08T03:04:21.455359Z","end":"2026-07-08T03:04:21.798559Z","steps":["trace[1338269439] 'process raft request' (duration: 342.972383ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:21.79865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:04:21.455326Z","time spent":"343.260692ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T03:04:21.79876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.552222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-2d72578c-16e5-4f04-b9c0-19675caf695e\" ","response":"range_response_count:1 size:1316"} {"level":"info","ts":"2026-07-08T03:04:21.798842Z","caller":"traceutil/trace.go:171","msg":"trace[1537439861] range","detail":"{range_begin:/registry/persistentvolumes/pvc-2d72578c-16e5-4f04-b9c0-19675caf695e; range_end:; response_count:1; response_revision:25069; }","duration":"297.661246ms","start":"2026-07-08T03:04:21.501158Z","end":"2026-07-08T03:04:21.798819Z","steps":["trace[1537439861] 'agreement among raft nodes before linearized reading' (duration: 297.434899ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:21.814959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.275473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinedeployments/\" range_end:\"/registry/cluster.x-k8s.io/machinedeployments0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T03:04:21.815048Z","caller":"traceutil/trace.go:171","msg":"trace[1401660150] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinedeployments/; range_end:/registry/cluster.x-k8s.io/machinedeployments0; response_count:0; response_revision:25070; }","duration":"298.433897ms","start":"2026-07-08T03:04:21.516589Z","end":"2026-07-08T03:04:21.815023Z","steps":["trace[1401660150] 'agreement among raft nodes before linearized reading' (duration: 298.18234ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:22.307288Z","caller":"traceutil/trace.go:171","msg":"trace[1612676607] transaction","detail":"{read_only:false; response_revision:25071; number_of_response:1; }","duration":"102.651901ms","start":"2026-07-08T03:04:22.204611Z","end":"2026-07-08T03:04:22.307263Z","steps":["trace[1612676607] 'process raft request' (duration: 102.490736ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:22.625075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.926817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-69574b4c5d-t2cn7.18c02faaa4d7f462\" ","response":"range_response_count:1 size:1138"} {"level":"info","ts":"2026-07-08T03:04:22.625149Z","caller":"traceutil/trace.go:171","msg":"trace[1098610884] range","detail":"{range_begin:/registry/events/openstack/barbican-api-69574b4c5d-t2cn7.18c02faaa4d7f462; range_end:; response_count:1; response_revision:25071; }","duration":"228.043131ms","start":"2026-07-08T03:04:22.397088Z","end":"2026-07-08T03:04:22.625131Z","steps":["trace[1098610884] 'range keys from in-memory index tree' (duration: 227.785084ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:22.657591Z","caller":"traceutil/trace.go:171","msg":"trace[322339108] transaction","detail":"{read_only:false; response_revision:25072; number_of_response:1; }","duration":"112.969215ms","start":"2026-07-08T03:04:22.544592Z","end":"2026-07-08T03:04:22.657561Z","steps":["trace[322339108] 'process raft request' (duration: 112.80707ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:22.745759Z","caller":"traceutil/trace.go:171","msg":"trace[1209485137] transaction","detail":"{read_only:false; response_revision:25073; number_of_response:1; }","duration":"118.820004ms","start":"2026-07-08T03:04:22.626908Z","end":"2026-07-08T03:04:22.745728Z","steps":["trace[1209485137] 'process raft request' (duration: 118.083352ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:22.955874Z","caller":"traceutil/trace.go:171","msg":"trace[877430027] transaction","detail":"{read_only:false; response_revision:25076; number_of_response:1; }","duration":"109.449106ms","start":"2026-07-08T03:04:22.846394Z","end":"2026-07-08T03:04:22.955844Z","steps":["trace[877430027] 'process raft request' (duration: 109.2843ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:22.955941Z","caller":"traceutil/trace.go:171","msg":"trace[1399670616] transaction","detail":"{read_only:false; response_revision:25075; number_of_response:1; }","duration":"125.881885ms","start":"2026-07-08T03:04:22.830028Z","end":"2026-07-08T03:04:22.95591Z","steps":["trace[1399670616] 'process raft request' (duration: 123.863797ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:23.270788Z","caller":"traceutil/trace.go:171","msg":"trace[1864900919] linearizableReadLoop","detail":"{readStateIndex:25893; appliedIndex:25892; }","duration":"132.185976ms","start":"2026-07-08T03:04:23.138552Z","end":"2026-07-08T03:04:23.270738Z","steps":["trace[1864900919] 'read index received' (duration: 120.414359ms)","trace[1864900919] 'applied index is now lower than readState.Index' (duration: 11.770227ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:04:23.270786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.222518ms","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-07-08T03:04:23.270904Z","caller":"traceutil/trace.go:171","msg":"trace[266132091] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25076; }","duration":"146.560657ms","start":"2026-07-08T03:04:23.124325Z","end":"2026-07-08T03:04:23.270886Z","steps":["trace[266132091] 'range keys from in-memory index tree' (duration: 146.000812ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:23.270822Z","caller":"traceutil/trace.go:171","msg":"trace[1166167814] transaction","detail":"{read_only:false; response_revision:25077; number_of_response:1; }","duration":"145.638601ms","start":"2026-07-08T03:04:23.125131Z","end":"2026-07-08T03:04:23.270769Z","steps":["trace[1166167814] 'process raft request' (duration: 133.872264ms)","trace[1166167814] 'compare' (duration: 11.375556ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:04:23.271018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.435463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinehealthchecks/\" range_end:\"/registry/cluster.x-k8s.io/machinehealthchecks0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-07-08T03:04:23.27104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.325376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" ","response":"range_response_count:32 size:277958"} {"level":"info","ts":"2026-07-08T03:04:23.271077Z","caller":"traceutil/trace.go:171","msg":"trace[185383384] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinehealthchecks/; range_end:/registry/cluster.x-k8s.io/machinehealthchecks0; response_count:0; response_revision:25077; }","duration":"132.519355ms","start":"2026-07-08T03:04:23.138539Z","end":"2026-07-08T03:04:23.271058Z","steps":["trace[185383384] 'agreement among raft nodes before linearized reading' (duration: 132.382951ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:23.271112Z","caller":"traceutil/trace.go:171","msg":"trace[2142867142] range","detail":"{range_begin:/registry/deployments/openstack/; range_end:/registry/deployments/openstack0; response_count:32; response_revision:25076; }","duration":"186.412188ms","start":"2026-07-08T03:04:23.084683Z","end":"2026-07-08T03:04:23.271095Z","steps":["trace[2142867142] 'range keys from in-memory index tree' (duration: 185.836243ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:23.453885Z","caller":"traceutil/trace.go:171","msg":"trace[1847271662] linearizableReadLoop","detail":"{readStateIndex:25894; appliedIndex:25893; }","duration":"173.113118ms","start":"2026-07-08T03:04:23.280738Z","end":"2026-07-08T03:04:23.453851Z","steps":["trace[1847271662] 'read index received' (duration: 100.733494ms)","trace[1847271662] 'applied index is now lower than readState.Index' (duration: 72.377654ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:04:23.454058Z","caller":"traceutil/trace.go:171","msg":"trace[1493337816] transaction","detail":"{read_only:false; response_revision:25078; number_of_response:1; }","duration":"178.534683ms","start":"2026-07-08T03:04:23.275492Z","end":"2026-07-08T03:04:23.454027Z","steps":["trace[1493337816] 'process raft request' (duration: 105.964254ms)","trace[1493337816] 'compare' (duration: 72.28364ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:04:23.454373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.619082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-07-08T03:04:23.454443Z","caller":"traceutil/trace.go:171","msg":"trace[1007894973] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25078; }","duration":"173.723297ms","start":"2026-07-08T03:04:23.280702Z","end":"2026-07-08T03:04:23.454426Z","steps":["trace[1007894973] 'agreement among raft nodes before linearized reading' (duration: 173.50157ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:23.495563Z","caller":"traceutil/trace.go:171","msg":"trace[1164956764] transaction","detail":"{read_only:false; response_revision:25080; number_of_response:1; }","duration":"213.538266ms","start":"2026-07-08T03:04:23.282005Z","end":"2026-07-08T03:04:23.495543Z","steps":["trace[1164956764] 'process raft request' (duration: 213.496384ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:23.495584Z","caller":"traceutil/trace.go:171","msg":"trace[1876260143] transaction","detail":"{read_only:false; response_revision:25079; number_of_response:1; }","duration":"213.925067ms","start":"2026-07-08T03:04:23.281628Z","end":"2026-07-08T03:04:23.495553Z","steps":["trace[1876260143] 'process raft request' (duration: 213.769533ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:23.495658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.608815ms","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-07-08T03:04:23.495688Z","caller":"traceutil/trace.go:171","msg":"trace[232306657] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25080; }","duration":"214.691639ms","start":"2026-07-08T03:04:23.280989Z","end":"2026-07-08T03:04:23.495681Z","steps":["trace[232306657] 'agreement among raft nodes before linearized reading' (duration: 214.580895ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:23.495741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.162903ms","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-07-08T03:04:23.495782Z","caller":"traceutil/trace.go:171","msg":"trace[138204806] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25080; }","duration":"214.238075ms","start":"2026-07-08T03:04:23.281534Z","end":"2026-07-08T03:04:23.495772Z","steps":["trace[138204806] 'agreement among raft nodes before linearized reading' (duration: 214.05035ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:23.803067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.837059ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-08T03:04:23.803301Z","caller":"traceutil/trace.go:171","msg":"trace[1043172752] transaction","detail":"{read_only:false; response_revision:25083; number_of_response:1; }","duration":"302.982297ms","start":"2026-07-08T03:04:23.500307Z","end":"2026-07-08T03:04:23.803289Z","steps":["trace[1043172752] 'process raft request' (duration: 302.951256ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:23.803344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:04:23.500284Z","time spent":"303.041969ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T03:04:23.803352Z","caller":"traceutil/trace.go:171","msg":"trace[1222457910] transaction","detail":"{read_only:false; response_revision:25081; number_of_response:1; }","duration":"345.648399ms","start":"2026-07-08T03:04:23.457671Z","end":"2026-07-08T03:04:23.803319Z","steps":["trace[1222457910] 'process raft request' (duration: 112.47122ms)","trace[1222457910] 'compare' (duration: 232.529821ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:04:23.803392Z","caller":"traceutil/trace.go:171","msg":"trace[604643309] transaction","detail":"{read_only:false; response_revision:25082; number_of_response:1; }","duration":"303.382428ms","start":"2026-07-08T03:04:23.499989Z","end":"2026-07-08T03:04:23.803372Z","steps":["trace[604643309] 'process raft request' (duration: 303.166562ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:23.803477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:04:23.499966Z","time spent":"303.474391ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T03:04:23.8035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:04:23.457653Z","time spent":"345.773753ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T03:04:23.973216Z","caller":"traceutil/trace.go:171","msg":"trace[1086669013] transaction","detail":"{read_only:false; response_revision:25084; number_of_response:1; }","duration":"168.656061ms","start":"2026-07-08T03:04:23.804541Z","end":"2026-07-08T03:04:23.973198Z","steps":["trace[1086669013] 'process raft request' (duration: 125.321509ms)","trace[1086669013] 'compare' (duration: 42.933691ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:04:23.973335Z","caller":"traceutil/trace.go:171","msg":"trace[2077287922] transaction","detail":"{read_only:false; response_revision:25085; number_of_response:1; }","duration":"152.498399ms","start":"2026-07-08T03:04:23.820829Z","end":"2026-07-08T03:04:23.973327Z","steps":["trace[2077287922] 'process raft request' (duration: 152.060966ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:24.63992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.497489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:562"} {"level":"info","ts":"2026-07-08T03:04:24.639996Z","caller":"traceutil/trace.go:171","msg":"trace[1206161203] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:25087; }","duration":"122.646863ms","start":"2026-07-08T03:04:24.517333Z","end":"2026-07-08T03:04:24.63998Z","steps":["trace[1206161203] 'range keys from in-memory index tree' (duration: 122.360485ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:24.640194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.346582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-08T03:04:24.640264Z","caller":"traceutil/trace.go:171","msg":"trace[474443540] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:25087; }","duration":"101.435495ms","start":"2026-07-08T03:04:24.53881Z","end":"2026-07-08T03:04:24.640245Z","steps":["trace[474443540] 'count revisions from in-memory index tree' (duration: 101.26097ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:24.640273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.955499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T03:04:24.640316Z","caller":"traceutil/trace.go:171","msg":"trace[924953623] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddressclaims/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddressclaims0; response_count:0; response_revision:25087; }","duration":"228.043532ms","start":"2026-07-08T03:04:24.412259Z","end":"2026-07-08T03:04:24.640303Z","steps":["trace[924953623] 'count revisions from in-memory index tree' (duration: 227.834136ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:24.792078Z","caller":"traceutil/trace.go:171","msg":"trace[1283448560] transaction","detail":"{read_only:false; response_revision:25088; number_of_response:1; }","duration":"147.933007ms","start":"2026-07-08T03:04:24.64412Z","end":"2026-07-08T03:04:24.792053Z","steps":["trace[1283448560] 'process raft request' (duration: 147.758472ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:25.137979Z","caller":"traceutil/trace.go:171","msg":"trace[1926110903] linearizableReadLoop","detail":"{readStateIndex:25905; appliedIndex:25904; }","duration":"177.781621ms","start":"2026-07-08T03:04:24.960174Z","end":"2026-07-08T03:04:25.137955Z","steps":["trace[1926110903] 'read index received' (duration: 177.666358ms)","trace[1926110903] 'applied index is now lower than readState.Index' (duration: 114.133µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:04:25.138072Z","caller":"traceutil/trace.go:171","msg":"trace[549814215] transaction","detail":"{read_only:false; response_revision:25089; number_of_response:1; }","duration":"475.17264ms","start":"2026-07-08T03:04:24.662886Z","end":"2026-07-08T03:04:25.138058Z","steps":["trace[549814215] 'process raft request' (duration: 474.919972ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:25.138172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:04:24.662859Z","time spent":"475.240082ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T03:04:25.138267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.094811ms","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-07-08T03:04:25.138314Z","caller":"traceutil/trace.go:171","msg":"trace[1106270882] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25089; }","duration":"178.178344ms","start":"2026-07-08T03:04:24.960121Z","end":"2026-07-08T03:04:25.1383Z","steps":["trace[1106270882] 'agreement among raft nodes before linearized reading' (duration: 177.943117ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:25.412681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.638211ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-08T03:04:25.412873Z","caller":"traceutil/trace.go:171","msg":"trace[1568477472] transaction","detail":"{read_only:false; response_revision:25091; number_of_response:1; }","duration":"270.298802ms","start":"2026-07-08T03:04:25.142558Z","end":"2026-07-08T03:04:25.412857Z","steps":["trace[1568477472] 'process raft request' (duration: 270.215759ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:25.413061Z","caller":"traceutil/trace.go:171","msg":"trace[1696122850] transaction","detail":"{read_only:false; response_revision:25090; number_of_response:1; }","duration":"451.276775ms","start":"2026-07-08T03:04:24.961773Z","end":"2026-07-08T03:04:25.41305Z","steps":["trace[1696122850] 'process raft request' (duration: 312.186541ms)","trace[1696122850] 'compare' (duration: 138.256189ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:04:25.413116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:04:24.961754Z","time spent":"451.329507ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T03:04:25.413237Z","caller":"traceutil/trace.go:171","msg":"trace[803142473] linearizableReadLoop","detail":"{readStateIndex:25906; appliedIndex:25905; }","duration":"275.162482ms","start":"2026-07-08T03:04:25.138041Z","end":"2026-07-08T03:04:25.413203Z","steps":["trace[803142473] 'read index received' (duration: 135.941835ms)","trace[803142473] 'applied index is now lower than readState.Index' (duration: 139.218897ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:04:25.413347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.477725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-08T03:04:25.413372Z","caller":"traceutil/trace.go:171","msg":"trace[484726159] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:25091; }","duration":"404.517927ms","start":"2026-07-08T03:04:25.008847Z","end":"2026-07-08T03:04:25.413365Z","steps":["trace[484726159] 'agreement among raft nodes before linearized reading' (duration: 404.450935ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:25.413788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:04:25.00879Z","time spent":"404.98667ms","remote":"127.0.0.1:32836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":31,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"warn","ts":"2026-07-08T03:04:25.433688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.108194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T03:04:25.433754Z","caller":"traceutil/trace.go:171","msg":"trace[1280521011] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:25092; }","duration":"294.192256ms","start":"2026-07-08T03:04:25.139547Z","end":"2026-07-08T03:04:25.43374Z","steps":["trace[1280521011] 'agreement among raft nodes before linearized reading' (duration: 294.065603ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:25.433793Z","caller":"traceutil/trace.go:171","msg":"trace[679421245] transaction","detail":"{read_only:false; response_revision:25092; number_of_response:1; }","duration":"157.335716ms","start":"2026-07-08T03:04:25.27644Z","end":"2026-07-08T03:04:25.433776Z","steps":["trace[679421245] 'process raft request' (duration: 157.060959ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:25.433784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.933891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T03:04:25.433849Z","caller":"traceutil/trace.go:171","msg":"trace[1251133551] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusagents/; range_end:/registry/monitoring.coreos.com/prometheusagents0; response_count:0; response_revision:25092; }","duration":"108.069665ms","start":"2026-07-08T03:04:25.325764Z","end":"2026-07-08T03:04:25.433834Z","steps":["trace[1251133551] 'agreement among raft nodes before linearized reading' (duration: 107.924641ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:25.433985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.402942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T03:04:25.434012Z","caller":"traceutil/trace.go:171","msg":"trace[274016363] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25092; }","duration":"235.461574ms","start":"2026-07-08T03:04:25.198543Z","end":"2026-07-08T03:04:25.434004Z","steps":["trace[274016363] 'agreement among raft nodes before linearized reading' (duration: 235.405652ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:25.731637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.798078ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-08T03:04:25.731741Z","caller":"traceutil/trace.go:171","msg":"trace[895933764] transaction","detail":"{read_only:false; response_revision:25093; number_of_response:1; }","duration":"269.760996ms","start":"2026-07-08T03:04:25.461962Z","end":"2026-07-08T03:04:25.731722Z","steps":["trace[895933764] 'process raft request' (duration: 118.794113ms)","trace[895933764] 'compare' (duration: 150.483309ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:04:25.734297Z","caller":"traceutil/trace.go:171","msg":"trace[1100124850] transaction","detail":"{read_only:false; response_revision:25094; number_of_response:1; }","duration":"232.422627ms","start":"2026-07-08T03:04:25.501848Z","end":"2026-07-08T03:04:25.73427Z","steps":["trace[1100124850] 'process raft request' (duration: 232.222021ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:25.734534Z","caller":"traceutil/trace.go:171","msg":"trace[347179000] transaction","detail":"{read_only:false; response_revision:25095; number_of_response:1; }","duration":"231.50552ms","start":"2026-07-08T03:04:25.502988Z","end":"2026-07-08T03:04:25.734494Z","steps":["trace[347179000] 'process raft request' (duration: 231.214522ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:26.095231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.896397ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-08T03:04:26.095438Z","caller":"traceutil/trace.go:171","msg":"trace[650407737] transaction","detail":"{read_only:false; response_revision:25096; number_of_response:1; }","duration":"284.19712ms","start":"2026-07-08T03:04:25.81119Z","end":"2026-07-08T03:04:26.095387Z","steps":["trace[650407737] 'process raft request' (duration: 137.080997ms)","trace[650407737] 'compare' (duration: 146.811534ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:04:26.095936Z","caller":"traceutil/trace.go:171","msg":"trace[1061873872] transaction","detail":"{read_only:false; response_revision:25097; number_of_response:1; }","duration":"284.440946ms","start":"2026-07-08T03:04:25.811468Z","end":"2026-07-08T03:04:26.095909Z","steps":["trace[1061873872] 'process raft request' (duration: 283.888031ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:26.096223Z","caller":"traceutil/trace.go:171","msg":"trace[526922726] transaction","detail":"{read_only:false; response_revision:25098; number_of_response:1; }","duration":"284.390346ms","start":"2026-07-08T03:04:25.8118Z","end":"2026-07-08T03:04:26.096191Z","steps":["trace[526922726] 'process raft request' (duration: 283.788578ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:26.284539Z","caller":"traceutil/trace.go:171","msg":"trace[2063201856] transaction","detail":"{read_only:false; response_revision:25099; number_of_response:1; }","duration":"301.719372ms","start":"2026-07-08T03:04:25.982795Z","end":"2026-07-08T03:04:26.284514Z","steps":["trace[2063201856] 'process raft request' (duration: 291.516879ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:26.284686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:04:25.982767Z","time spent":"301.840576ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T03:04:26.285017Z","caller":"traceutil/trace.go:171","msg":"trace[1655488112] transaction","detail":"{read_only:false; response_revision:25100; number_of_response:1; }","duration":"301.780504ms","start":"2026-07-08T03:04:25.98322Z","end":"2026-07-08T03:04:26.285001Z","steps":["trace[1655488112] 'process raft request' (duration: 301.200547ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:26.285088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:04:25.983212Z","time spent":"301.834495ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T03:04:26.285192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.278561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.153\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-07-08T03:04:26.285228Z","caller":"traceutil/trace.go:171","msg":"trace[1933498043] range","detail":"{range_begin:/registry/masterleases/199.204.45.153; range_end:; response_count:1; response_revision:25100; }","duration":"138.366253ms","start":"2026-07-08T03:04:26.146851Z","end":"2026-07-08T03:04:26.285218Z","steps":["trace[1933498043] 'agreement among raft nodes before linearized reading' (duration: 138.224099ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:26.284753Z","caller":"traceutil/trace.go:171","msg":"trace[2023042863] linearizableReadLoop","detail":"{readStateIndex:25916; appliedIndex:25914; }","duration":"137.822947ms","start":"2026-07-08T03:04:26.14691Z","end":"2026-07-08T03:04:26.284733Z","steps":["trace[2023042863] 'read index received' (duration: 127.379068ms)","trace[2023042863] 'applied index is now lower than readState.Index' (duration: 10.443179ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:04:26.546408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.50028ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"info","ts":"2026-07-08T03:04:26.546917Z","caller":"traceutil/trace.go:171","msg":"trace[446054367] transaction","detail":"{read_only:false; response_revision:25101; number_of_response:1; }","duration":"211.93284ms","start":"2026-07-08T03:04:26.334953Z","end":"2026-07-08T03:04:26.546886Z","steps":["trace[446054367] 'process raft request' (duration: 211.539709ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:41.64807Z","caller":"traceutil/trace.go:171","msg":"trace[1403689061] linearizableReadLoop","detail":"{readStateIndex:26087; appliedIndex:26084; }","duration":"159.289822ms","start":"2026-07-08T03:04:41.48875Z","end":"2026-07-08T03:04:41.64804Z","steps":["trace[1403689061] 'read index received' (duration: 16.286946ms)","trace[1403689061] 'applied index is now lower than readState.Index' (duration: 143.001636ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:04:41.648125Z","caller":"traceutil/trace.go:171","msg":"trace[2112628716] transaction","detail":"{read_only:false; response_revision:25268; number_of_response:1; }","duration":"162.017701ms","start":"2026-07-08T03:04:41.486088Z","end":"2026-07-08T03:04:41.648106Z","steps":["trace[2112628716] 'process raft request' (duration: 161.898988ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:41.648124Z","caller":"traceutil/trace.go:171","msg":"trace[219077010] transaction","detail":"{read_only:false; response_revision:25267; number_of_response:1; }","duration":"183.902627ms","start":"2026-07-08T03:04:41.464174Z","end":"2026-07-08T03:04:41.648076Z","steps":["trace[219077010] 'process raft request' (duration: 183.66273ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:41.648345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.580941ms","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-07-08T03:04:41.648414Z","caller":"traceutil/trace.go:171","msg":"trace[1944986431] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25268; }","duration":"159.663523ms","start":"2026-07-08T03:04:41.488733Z","end":"2026-07-08T03:04:41.648397Z","steps":["trace[1944986431] 'agreement among raft nodes before linearized reading' (duration: 159.446217ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:41.648935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.826211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cb253887-a249-43bc-b242-8132f21009eb\" ","response":"range_response_count:1 size:3644"} {"level":"info","ts":"2026-07-08T03:04:41.649003Z","caller":"traceutil/trace.go:171","msg":"trace[609766514] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cb253887-a249-43bc-b242-8132f21009eb; range_end:; response_count:1; response_revision:25268; }","duration":"134.947575ms","start":"2026-07-08T03:04:41.514043Z","end":"2026-07-08T03:04:41.64899Z","steps":["trace[609766514] 'agreement among raft nodes before linearized reading' (duration: 134.523443ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:42.044772Z","caller":"traceutil/trace.go:171","msg":"trace[224257440] linearizableReadLoop","detail":"{readStateIndex:26092; appliedIndex:26091; }","duration":"156.654267ms","start":"2026-07-08T03:04:41.88807Z","end":"2026-07-08T03:04:42.044724Z","steps":["trace[224257440] 'read index received' (duration: 142.43643ms)","trace[224257440] 'applied index is now lower than readState.Index' (duration: 14.214307ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:04:42.044712Z","caller":"traceutil/trace.go:171","msg":"trace[489513513] transaction","detail":"{read_only:false; response_revision:25273; number_of_response:1; }","duration":"159.782397ms","start":"2026-07-08T03:04:41.884892Z","end":"2026-07-08T03:04:42.044674Z","steps":["trace[489513513] 'process raft request' (duration: 145.5969ms)","trace[489513513] 'compare' (duration: 13.899657ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:04:42.201374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.75618ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-07-08T03:04:42.201474Z","caller":"traceutil/trace.go:171","msg":"trace[494967522] linearizableReadLoop","detail":"{readStateIndex:26093; appliedIndex:26092; }","duration":"156.593925ms","start":"2026-07-08T03:04:42.044863Z","end":"2026-07-08T03:04:42.201457Z","steps":["trace[494967522] 'read index received' (duration: 100.533µs)","trace[494967522] 'applied index is now lower than readState.Index' (duration: 156.491722ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:04:42.20162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.52764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"warn","ts":"2026-07-08T03:04:42.201681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.47845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cb253887-a249-43bc-b242-8132f21009eb\" ","response":"range_response_count:1 size:3644"} {"level":"info","ts":"2026-07-08T03:04:42.201734Z","caller":"traceutil/trace.go:171","msg":"trace[561704420] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:25273; }","duration":"313.699295ms","start":"2026-07-08T03:04:41.888006Z","end":"2026-07-08T03:04:42.201706Z","steps":["trace[561704420] 'agreement among raft nodes before linearized reading' (duration: 156.918215ms)","trace[561704420] 'count revisions from in-memory index tree' (duration: 156.610576ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:04:42.201748Z","caller":"traceutil/trace.go:171","msg":"trace[831432347] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cb253887-a249-43bc-b242-8132f21009eb; range_end:; response_count:1; response_revision:25273; }","duration":"210.600373ms","start":"2026-07-08T03:04:41.991131Z","end":"2026-07-08T03:04:42.201731Z","steps":["trace[831432347] 'agreement among raft nodes before linearized reading' (duration: 210.407207ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:42.201801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:04:41.887959Z","time spent":"313.827389ms","remote":"127.0.0.1:60820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":144,"response size":32,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"info","ts":"2026-07-08T03:04:42.347571Z","caller":"traceutil/trace.go:171","msg":"trace[2056449888] transaction","detail":"{read_only:false; response_revision:25274; number_of_response:1; }","duration":"141.72984ms","start":"2026-07-08T03:04:42.20579Z","end":"2026-07-08T03:04:42.34752Z","steps":["trace[2056449888] 'process raft request' (duration: 141.551764ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:42.607263Z","caller":"traceutil/trace.go:171","msg":"trace[342896576] transaction","detail":"{read_only:false; response_revision:25275; number_of_response:1; }","duration":"400.948063ms","start":"2026-07-08T03:04:42.206285Z","end":"2026-07-08T03:04:42.607233Z","steps":["trace[342896576] 'process raft request' (duration: 400.602173ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:42.607314Z","caller":"traceutil/trace.go:171","msg":"trace[1634825203] transaction","detail":"{read_only:false; response_revision:25276; number_of_response:1; }","duration":"400.958484ms","start":"2026-07-08T03:04:42.206333Z","end":"2026-07-08T03:04:42.607291Z","steps":["trace[1634825203] 'process raft request' (duration: 400.733947ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:42.607415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:04:42.206311Z","time spent":"401.042767ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T03:04:42.607422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:04:42.206276Z","time spent":"401.055287ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T03:04:42.607469Z","caller":"traceutil/trace.go:171","msg":"trace[1972523755] transaction","detail":"{read_only:false; response_revision:25277; number_of_response:1; }","duration":"399.855922ms","start":"2026-07-08T03:04:42.207578Z","end":"2026-07-08T03:04:42.607434Z","steps":["trace[1972523755] 'process raft request' (duration: 399.567424ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:42.607643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:04:42.20757Z","time spent":"399.970726ms","remote":"127.0.0.1:60876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3746,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T03:04:42.607826Z","caller":"traceutil/trace.go:171","msg":"trace[138306922] transaction","detail":"{read_only:false; response_revision:25279; number_of_response:1; }","duration":"262.628363ms","start":"2026-07-08T03:04:42.345185Z","end":"2026-07-08T03:04:42.607813Z","steps":["trace[138306922] 'process raft request' (duration: 262.503149ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:42.607848Z","caller":"traceutil/trace.go:171","msg":"trace[2063168837] linearizableReadLoop","detail":"{readStateIndex:26097; appliedIndex:26093; }","duration":"388.662632ms","start":"2026-07-08T03:04:42.219155Z","end":"2026-07-08T03:04:42.607817Z","steps":["trace[2063168837] 'read index received' (duration: 128.253213ms)","trace[2063168837] 'applied index is now lower than readState.Index' (duration: 260.407969ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:04:42.607918Z","caller":"traceutil/trace.go:171","msg":"trace[569369319] transaction","detail":"{read_only:false; response_revision:25278; number_of_response:1; }","duration":"264.883427ms","start":"2026-07-08T03:04:42.34301Z","end":"2026-07-08T03:04:42.607894Z","steps":["trace[569369319] 'process raft request' (duration: 264.232277ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:42.608094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.906128ms","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:6"} {"level":"info","ts":"2026-07-08T03:04:42.608169Z","caller":"traceutil/trace.go:171","msg":"trace[214244649] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:25280; }","duration":"389.029042ms","start":"2026-07-08T03:04:42.21912Z","end":"2026-07-08T03:04:42.608149Z","steps":["trace[214244649] 'agreement among raft nodes before linearized reading' (duration: 388.872178ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:42.608227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.390145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3309"} {"level":"info","ts":"2026-07-08T03:04:42.608267Z","caller":"traceutil/trace.go:171","msg":"trace[661035601] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:25280; }","duration":"108.477287ms","start":"2026-07-08T03:04:42.499776Z","end":"2026-07-08T03:04:42.608253Z","steps":["trace[661035601] 'agreement among raft nodes before linearized reading' (duration: 108.346943ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:42.608296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:04:42.219109Z","time spent":"389.095765ms","remote":"127.0.0.1:43512","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-07-08T03:04:42.782795Z","caller":"traceutil/trace.go:171","msg":"trace[480052698] linearizableReadLoop","detail":"{readStateIndex:26101; appliedIndex:26100; }","duration":"154.409892ms","start":"2026-07-08T03:04:42.628357Z","end":"2026-07-08T03:04:42.782766Z","steps":["trace[480052698] 'read index received' (duration: 122.069586ms)","trace[480052698] 'applied index is now lower than readState.Index' (duration: 32.338726ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:04:42.782889Z","caller":"traceutil/trace.go:171","msg":"trace[933075762] transaction","detail":"{read_only:false; response_revision:25281; number_of_response:1; }","duration":"158.279323ms","start":"2026-07-08T03:04:42.624581Z","end":"2026-07-08T03:04:42.78286Z","steps":["trace[933075762] 'process raft request' (duration: 125.868935ms)","trace[933075762] 'compare' (duration: 32.169321ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:04:42.783119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.744222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" ","response":"range_response_count:1 size:9604"} {"level":"info","ts":"2026-07-08T03:04:42.783157Z","caller":"traceutil/trace.go:171","msg":"trace[427538803] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-manila-server; range_end:; response_count:1; response_revision:25281; }","duration":"154.828514ms","start":"2026-07-08T03:04:42.628317Z","end":"2026-07-08T03:04:42.783146Z","steps":["trace[427538803] 'agreement among raft nodes before linearized reading' (duration: 154.593957ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:42.78326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.476497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cb253887-a249-43bc-b242-8132f21009eb\" ","response":"range_response_count:1 size:3764"} {"level":"info","ts":"2026-07-08T03:04:42.78334Z","caller":"traceutil/trace.go:171","msg":"trace[1727083126] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cb253887-a249-43bc-b242-8132f21009eb; range_end:; response_count:1; response_revision:25281; }","duration":"130.616911ms","start":"2026-07-08T03:04:42.652701Z","end":"2026-07-08T03:04:42.783318Z","steps":["trace[1727083126] 'agreement among raft nodes before linearized reading' (duration: 130.318362ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:42.990465Z","caller":"traceutil/trace.go:171","msg":"trace[417698815] linearizableReadLoop","detail":"{readStateIndex:26102; appliedIndex:26101; }","duration":"192.961717ms","start":"2026-07-08T03:04:42.797482Z","end":"2026-07-08T03:04:42.990443Z","steps":["trace[417698815] 'read index received' (duration: 124.918409ms)","trace[417698815] 'applied index is now lower than readState.Index' (duration: 68.042198ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:04:42.990493Z","caller":"traceutil/trace.go:171","msg":"trace[595843137] transaction","detail":"{read_only:false; response_revision:25282; number_of_response:1; }","duration":"202.212461ms","start":"2026-07-08T03:04:42.788264Z","end":"2026-07-08T03:04:42.990476Z","steps":["trace[595843137] 'process raft request' (duration: 134.205663ms)","trace[595843137] 'compare' (duration: 67.868724ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:04:42.990618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.120822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" ","response":"range_response_count:1 size:9604"} {"level":"info","ts":"2026-07-08T03:04:42.99065Z","caller":"traceutil/trace.go:171","msg":"trace[192443800] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-manila-server; range_end:; response_count:1; response_revision:25282; }","duration":"193.178893ms","start":"2026-07-08T03:04:42.797453Z","end":"2026-07-08T03:04:42.990632Z","steps":["trace[192443800] 'agreement among raft nodes before linearized reading' (duration: 193.068279ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:43.254002Z","caller":"traceutil/trace.go:171","msg":"trace[576272028] linearizableReadLoop","detail":"{readStateIndex:26103; appliedIndex:26102; }","duration":"184.999179ms","start":"2026-07-08T03:04:43.068982Z","end":"2026-07-08T03:04:43.253981Z","steps":["trace[576272028] 'read index received' (duration: 184.891666ms)","trace[576272028] 'applied index is now lower than readState.Index' (duration: 106.183µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:04:43.254067Z","caller":"traceutil/trace.go:171","msg":"trace[8057879] transaction","detail":"{read_only:false; response_revision:25283; number_of_response:1; }","duration":"257.010301ms","start":"2026-07-08T03:04:42.997018Z","end":"2026-07-08T03:04:43.254028Z","steps":["trace[8057879] 'process raft request' (duration: 256.801905ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:43.255938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.922834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-07-08T03:04:43.256066Z","caller":"traceutil/trace.go:171","msg":"trace[1664318847] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:25283; }","duration":"187.101379ms","start":"2026-07-08T03:04:43.068939Z","end":"2026-07-08T03:04:43.25604Z","steps":["trace[1664318847] 'agreement among raft nodes before linearized reading' (duration: 185.131793ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:43.457967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.472481ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-08T03:04:43.458077Z","caller":"traceutil/trace.go:171","msg":"trace[394477454] linearizableReadLoop","detail":"{readStateIndex:26104; appliedIndex:26103; }","duration":"204.000363ms","start":"2026-07-08T03:04:43.25406Z","end":"2026-07-08T03:04:43.45806Z","steps":["trace[394477454] 'read index received' (duration: 98.316186ms)","trace[394477454] 'applied index is now lower than readState.Index' (duration: 105.683037ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:04:43.458098Z","caller":"traceutil/trace.go:171","msg":"trace[1539554408] transaction","detail":"{read_only:false; response_revision:25284; number_of_response:1; }","duration":"229.210895ms","start":"2026-07-08T03:04:43.228864Z","end":"2026-07-08T03:04:43.458075Z","steps":["trace[1539554408] 'process raft request' (duration: 123.538988ms)","trace[1539554408] 'compare' (duration: 105.329077ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:04:43.458163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.465914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-08T03:04:43.458201Z","caller":"traceutil/trace.go:171","msg":"trace[282298067] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:25284; }","duration":"382.523945ms","start":"2026-07-08T03:04:43.075668Z","end":"2026-07-08T03:04:43.458192Z","steps":["trace[282298067] 'agreement among raft nodes before linearized reading' (duration: 382.440983ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:43.458275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:04:43.075659Z","time spent":"382.605898ms","remote":"127.0.0.1:60852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":16,"response size":31,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"warn","ts":"2026-07-08T03:04:43.458534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.157091ms","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-07-08T03:04:43.458578Z","caller":"traceutil/trace.go:171","msg":"trace[924751507] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25284; }","duration":"348.213693ms","start":"2026-07-08T03:04:43.110354Z","end":"2026-07-08T03:04:43.458568Z","steps":["trace[924751507] 'agreement among raft nodes before linearized reading' (duration: 348.061378ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:43.458607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:04:43.110316Z","time spent":"348.283475ms","remote":"127.0.0.1:60876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12236,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-07-08T03:04:43.83828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.549843ms","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-07-08T03:04:43.838363Z","caller":"traceutil/trace.go:171","msg":"trace[1949968747] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:25284; }","duration":"194.759139ms","start":"2026-07-08T03:04:43.643587Z","end":"2026-07-08T03:04:43.838346Z","steps":["trace[1949968747] 'count revisions from in-memory index tree' (duration: 194.43394ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:43.838718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.683091ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-08T03:04:43.838802Z","caller":"traceutil/trace.go:171","msg":"trace[344922871] transaction","detail":"{read_only:false; response_revision:25285; number_of_response:1; }","duration":"185.137443ms","start":"2026-07-08T03:04:43.653649Z","end":"2026-07-08T03:04:43.838786Z","steps":["trace[344922871] 'process raft request' (duration: 38.316178ms)","trace[344922871] 'compare' (duration: 146.521237ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:04:43.956434Z","caller":"traceutil/trace.go:171","msg":"trace[1983191338] linearizableReadLoop","detail":"{readStateIndex:26106; appliedIndex:26104; }","duration":"281.993047ms","start":"2026-07-08T03:04:43.674416Z","end":"2026-07-08T03:04:43.956409Z","steps":["trace[1983191338] 'read index received' (duration: 17.480551ms)","trace[1983191338] 'applied index is now lower than readState.Index' (duration: 264.511556ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:04:43.956555Z","caller":"traceutil/trace.go:171","msg":"trace[548355288] transaction","detail":"{read_only:false; response_revision:25286; number_of_response:1; }","duration":"302.340689ms","start":"2026-07-08T03:04:43.654201Z","end":"2026-07-08T03:04:43.956541Z","steps":["trace[548355288] 'process raft request' (duration: 296.717318ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:43.95667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:04:43.654174Z","time spent":"302.415112ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T03:04:43.956723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.302126ms","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-07-08T03:04:43.956775Z","caller":"traceutil/trace.go:171","msg":"trace[1102811690] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25286; }","duration":"282.394139ms","start":"2026-07-08T03:04:43.674368Z","end":"2026-07-08T03:04:43.956763Z","steps":["trace[1102811690] 'agreement among raft nodes before linearized reading' (duration: 282.263105ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:44.242033Z","caller":"traceutil/trace.go:171","msg":"trace[1647013784] linearizableReadLoop","detail":"{readStateIndex:26108; appliedIndex:26106; }","duration":"285.512428ms","start":"2026-07-08T03:04:43.956498Z","end":"2026-07-08T03:04:44.242011Z","steps":["trace[1647013784] 'read index received' (duration: 253.193182ms)","trace[1647013784] 'applied index is now lower than readState.Index' (duration: 32.318236ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:04:44.242155Z","caller":"traceutil/trace.go:171","msg":"trace[339000589] transaction","detail":"{read_only:false; response_revision:25287; number_of_response:1; }","duration":"368.108912ms","start":"2026-07-08T03:04:43.874034Z","end":"2026-07-08T03:04:44.242143Z","steps":["trace[339000589] 'process raft request' (duration: 335.651303ms)","trace[339000589] 'compare' (duration: 32.084859ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:04:44.242314Z","caller":"traceutil/trace.go:171","msg":"trace[847203349] transaction","detail":"{read_only:false; response_revision:25289; number_of_response:1; }","duration":"281.312857ms","start":"2026-07-08T03:04:43.960975Z","end":"2026-07-08T03:04:44.242288Z","steps":["trace[847203349] 'process raft request' (duration: 281.006038ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:44.242691Z","caller":"traceutil/trace.go:171","msg":"trace[184040536] transaction","detail":"{read_only:false; response_revision:25290; number_of_response:1; }","duration":"236.921685ms","start":"2026-07-08T03:04:44.005757Z","end":"2026-07-08T03:04:44.242679Z","steps":["trace[184040536] 'process raft request' (duration: 236.41591ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:44.243031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.139675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cb253887-a249-43bc-b242-8132f21009eb\" ","response":"range_response_count:1 size:3764"} {"level":"warn","ts":"2026-07-08T03:04:44.243072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.204432ms","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-07-08T03:04:44.24311Z","caller":"traceutil/trace.go:171","msg":"trace[2064150522] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cb253887-a249-43bc-b242-8132f21009eb; range_end:; response_count:1; response_revision:25290; }","duration":"455.271599ms","start":"2026-07-08T03:04:43.787826Z","end":"2026-07-08T03:04:44.243097Z","steps":["trace[2064150522] 'agreement among raft nodes before linearized reading' (duration: 455.024202ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:44.243117Z","caller":"traceutil/trace.go:171","msg":"trace[2053478532] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25290; }","duration":"194.289915ms","start":"2026-07-08T03:04:44.048813Z","end":"2026-07-08T03:04:44.243103Z","steps":["trace[2053478532] 'agreement among raft nodes before linearized reading' (duration: 194.156901ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:44.243145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:04:43.787803Z","time spent":"455.331501ms","remote":"127.0.0.1:60876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3787,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cb253887-a249-43bc-b242-8132f21009eb\" "} {"level":"info","ts":"2026-07-08T03:04:44.243178Z","caller":"traceutil/trace.go:171","msg":"trace[1446673138] transaction","detail":"{read_only:false; response_revision:25288; number_of_response:1; }","duration":"355.064878ms","start":"2026-07-08T03:04:43.888094Z","end":"2026-07-08T03:04:44.243159Z","steps":["trace[1446673138] 'process raft request' (duration: 353.829553ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:44.243288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:04:43.88805Z","time spent":"355.167532ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T03:04:44.244228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:04:43.874008Z","time spent":"368.172795ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T03:04:46.443495Z","caller":"traceutil/trace.go:171","msg":"trace[1648140333] linearizableReadLoop","detail":"{readStateIndex:26126; appliedIndex:26124; }","duration":"191.739978ms","start":"2026-07-08T03:04:46.251731Z","end":"2026-07-08T03:04:46.443471Z","steps":["trace[1648140333] 'read index received' (duration: 54.499273ms)","trace[1648140333] 'applied index is now lower than readState.Index' (duration: 137.239765ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:04:46.443733Z","caller":"traceutil/trace.go:171","msg":"trace[1604608949] transaction","detail":"{read_only:false; response_revision:25305; number_of_response:1; }","duration":"195.129565ms","start":"2026-07-08T03:04:46.248564Z","end":"2026-07-08T03:04:46.443694Z","steps":["trace[1604608949] 'process raft request' (duration: 194.712654ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:46.44383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.070307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cb253887-a249-43bc-b242-8132f21009eb\" ","response":"range_response_count:1 size:3950"} {"level":"info","ts":"2026-07-08T03:04:46.443929Z","caller":"traceutil/trace.go:171","msg":"trace[796351502] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cb253887-a249-43bc-b242-8132f21009eb; range_end:; response_count:1; response_revision:25305; }","duration":"192.198211ms","start":"2026-07-08T03:04:46.251704Z","end":"2026-07-08T03:04:46.443903Z","steps":["trace[796351502] 'agreement among raft nodes before linearized reading' (duration: 191.958764ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:04:46.445867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.102025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-07-08T03:04:46.445922Z","caller":"traceutil/trace.go:171","msg":"trace[1856956147] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25306; }","duration":"134.204208ms","start":"2026-07-08T03:04:46.311704Z","end":"2026-07-08T03:04:46.445908Z","steps":["trace[1856956147] 'agreement among raft nodes before linearized reading' (duration: 133.756745ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:46.446205Z","caller":"traceutil/trace.go:171","msg":"trace[114750124] transaction","detail":"{read_only:false; response_revision:25306; number_of_response:1; }","duration":"116.980164ms","start":"2026-07-08T03:04:46.329213Z","end":"2026-07-08T03:04:46.446193Z","steps":["trace[114750124] 'process raft request' (duration: 116.17432ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:04:47.967481Z","caller":"traceutil/trace.go:171","msg":"trace[637483990] transaction","detail":"{read_only:false; response_revision:25324; number_of_response:1; }","duration":"116.303786ms","start":"2026-07-08T03:04:47.851137Z","end":"2026-07-08T03:04:47.967441Z","steps":["trace[637483990] 'process raft request' (duration: 116.079459ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:05:03.727194Z","caller":"traceutil/trace.go:171","msg":"trace[1336083226] transaction","detail":"{read_only:false; response_revision:25495; number_of_response:1; }","duration":"194.396564ms","start":"2026-07-08T03:05:03.532775Z","end":"2026-07-08T03:05:03.727171Z","steps":["trace[1336083226] 'process raft request' (duration: 194.269311ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:05:03.963044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.862679ms","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-07-08T03:05:03.963108Z","caller":"traceutil/trace.go:171","msg":"trace[1978393953] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25495; }","duration":"126.965622ms","start":"2026-07-08T03:05:03.83613Z","end":"2026-07-08T03:05:03.963095Z","steps":["trace[1978393953] 'range keys from in-memory index tree' (duration: 126.727914ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:05:04.33909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.481465ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-08T03:05:04.339217Z","caller":"traceutil/trace.go:171","msg":"trace[1087355471] linearizableReadLoop","detail":"{readStateIndex:26322; appliedIndex:26320; }","duration":"250.06449ms","start":"2026-07-08T03:05:04.089129Z","end":"2026-07-08T03:05:04.339193Z","steps":["trace[1087355471] 'read index received' (duration: 20.272581ms)","trace[1087355471] 'applied index is now lower than readState.Index' (duration: 229.790199ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:05:04.339236Z","caller":"traceutil/trace.go:171","msg":"trace[978790278] transaction","detail":"{read_only:false; response_revision:25497; number_of_response:1; }","duration":"253.457518ms","start":"2026-07-08T03:05:04.085758Z","end":"2026-07-08T03:05:04.339215Z","steps":["trace[978790278] 'process raft request' (duration: 95.53139ms)","trace[978790278] 'compare' (duration: 157.355122ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:05:04.339385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.232015ms","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-07-08T03:05:04.339474Z","caller":"traceutil/trace.go:171","msg":"trace[185940807] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25497; }","duration":"250.373549ms","start":"2026-07-08T03:05:04.089076Z","end":"2026-07-08T03:05:04.339449Z","steps":["trace[185940807] 'agreement among raft nodes before linearized reading' (duration: 250.216564ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:05:04.350704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.971941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T03:05:04.350977Z","caller":"traceutil/trace.go:171","msg":"trace[1518701595] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25498; }","duration":"157.311871ms","start":"2026-07-08T03:05:04.193648Z","end":"2026-07-08T03:05:04.35096Z","steps":["trace[1518701595] 'agreement among raft nodes before linearized reading' (duration: 156.872978ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:05:04.497174Z","caller":"traceutil/trace.go:171","msg":"trace[921637547] transaction","detail":"{read_only:false; response_revision:25499; number_of_response:1; }","duration":"112.215107ms","start":"2026-07-08T03:05:04.384929Z","end":"2026-07-08T03:05:04.497144Z","steps":["trace[921637547] 'process raft request' (duration: 111.203449ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:05:04.86115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.222302ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-08T03:05:04.861324Z","caller":"traceutil/trace.go:171","msg":"trace[1774471261] transaction","detail":"{read_only:false; response_revision:25501; number_of_response:1; }","duration":"178.405404ms","start":"2026-07-08T03:05:04.682907Z","end":"2026-07-08T03:05:04.861313Z","steps":["trace[1774471261] 'process raft request' (duration: 178.312021ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:05:04.861503Z","caller":"traceutil/trace.go:171","msg":"trace[1772370307] transaction","detail":"{read_only:false; response_revision:25500; number_of_response:1; }","duration":"349.862611ms","start":"2026-07-08T03:05:04.511634Z","end":"2026-07-08T03:05:04.861497Z","steps":["trace[1772370307] 'process raft request' (duration: 135.240658ms)","trace[1772370307] 'compare' (duration: 213.7862ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:05:04.861533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:05:04.511598Z","time spent":"349.917173ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T03:05:04.861596Z","caller":"traceutil/trace.go:171","msg":"trace[286004665] linearizableReadLoop","detail":"{readStateIndex:26325; appliedIndex:26324; }","duration":"325.247586ms","start":"2026-07-08T03:05:04.536342Z","end":"2026-07-08T03:05:04.86159Z","steps":["trace[286004665] 'read index received' (duration: 110.464798ms)","trace[286004665] 'applied index is now lower than readState.Index' (duration: 214.782328ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:05:04.861718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.385559ms","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-07-08T03:05:04.861734Z","caller":"traceutil/trace.go:171","msg":"trace[490642756] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25501; }","duration":"325.430961ms","start":"2026-07-08T03:05:04.536298Z","end":"2026-07-08T03:05:04.861729Z","steps":["trace[490642756] 'agreement among raft nodes before linearized reading' (duration: 325.359499ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:05:04.861749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:05:04.536285Z","time spent":"325.459822ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-08T03:05:05.154968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.986373ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-08T03:05:05.155208Z","caller":"traceutil/trace.go:171","msg":"trace[1234284816] transaction","detail":"{read_only:false; response_revision:25504; number_of_response:1; }","duration":"290.500039ms","start":"2026-07-08T03:05:04.864689Z","end":"2026-07-08T03:05:05.155189Z","steps":["trace[1234284816] 'process raft request' (duration: 290.458648ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:05:05.155331Z","caller":"traceutil/trace.go:171","msg":"trace[2120189058] transaction","detail":"{read_only:false; response_revision:25502; number_of_response:1; }","duration":"467.151364ms","start":"2026-07-08T03:05:04.688113Z","end":"2026-07-08T03:05:05.155264Z","steps":["trace[2120189058] 'process raft request' (duration: 311.79079ms)","trace[2120189058] 'compare' (duration: 154.702505ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:05:05.155349Z","caller":"traceutil/trace.go:171","msg":"trace[1377205656] transaction","detail":"{read_only:false; response_revision:25503; number_of_response:1; }","duration":"467.091563ms","start":"2026-07-08T03:05:04.688231Z","end":"2026-07-08T03:05:05.155322Z","steps":["trace[1377205656] 'process raft request' (duration: 466.829685ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:05:05.155482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:05:04.688091Z","time spent":"467.313429ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T03:05:05.155528Z","caller":"traceutil/trace.go:171","msg":"trace[82731442] linearizableReadLoop","detail":"{readStateIndex:26328; appliedIndex:26326; }","duration":"293.909428ms","start":"2026-07-08T03:05:04.861605Z","end":"2026-07-08T03:05:05.155514Z","steps":["trace[82731442] 'read index received' (duration: 138.271236ms)","trace[82731442] 'applied index is now lower than readState.Index' (duration: 155.636602ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:05:05.155483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:05:04.688199Z","time spent":"467.213686ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T03:05:05.155726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.308332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/routerinterfaces/\" range_end:\"/registry/openstack.k-orc.cloud/routerinterfaces0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T03:05:05.155759Z","caller":"traceutil/trace.go:171","msg":"trace[1735029946] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/routerinterfaces/; range_end:/registry/openstack.k-orc.cloud/routerinterfaces0; response_count:0; response_revision:25504; }","duration":"134.428915ms","start":"2026-07-08T03:05:05.021319Z","end":"2026-07-08T03:05:05.155748Z","steps":["trace[1735029946] 'agreement among raft nodes before linearized reading' (duration: 134.361713ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:05:05.155843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"619.165384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"warn","ts":"2026-07-08T03:05:05.155895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.48238ms","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-07-08T03:05:05.155927Z","caller":"traceutil/trace.go:171","msg":"trace[941364514] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25504; }","duration":"619.288628ms","start":"2026-07-08T03:05:04.53662Z","end":"2026-07-08T03:05:05.155909Z","steps":["trace[941364514] 'agreement among raft nodes before linearized reading' (duration: 619.04689ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:05:05.155952Z","caller":"traceutil/trace.go:171","msg":"trace[1960615821] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25504; }","duration":"447.566174ms","start":"2026-07-08T03:05:04.70837Z","end":"2026-07-08T03:05:05.155936Z","steps":["trace[1960615821] 'agreement among raft nodes before linearized reading' (duration: 447.394148ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:05:05.155968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:05:04.536614Z","time spent":"619.34506ms","remote":"127.0.0.1:60958","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-07-08T03:05:05.156008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.287105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T03:05:05.156119Z","caller":"traceutil/trace.go:171","msg":"trace[1695642945] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:25504; }","duration":"455.44475ms","start":"2026-07-08T03:05:04.700653Z","end":"2026-07-08T03:05:05.156098Z","steps":["trace[1695642945] 'agreement among raft nodes before linearized reading' (duration: 455.240033ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:05:05.156024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:05:04.708356Z","time spent":"447.656176ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-08T03:05:05.156224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:05:04.700633Z","time spent":"455.570743ms","remote":"127.0.0.1:38412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" count_only:true "} {"level":"warn","ts":"2026-07-08T03:05:05.156189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.981531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-07-08T03:05:05.156344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.892972ms","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-07-08T03:05:05.156503Z","caller":"traceutil/trace.go:171","msg":"trace[1068960433] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25504; }","duration":"607.149879ms","start":"2026-07-08T03:05:04.549329Z","end":"2026-07-08T03:05:05.156479Z","steps":["trace[1068960433] 'agreement among raft nodes before linearized reading' (duration: 606.641075ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:05:05.156612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:05:04.549314Z","time spent":"607.277842ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-08T03:05:05.15651Z","caller":"traceutil/trace.go:171","msg":"trace[694840416] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25504; }","duration":"452.248588ms","start":"2026-07-08T03:05:04.704154Z","end":"2026-07-08T03:05:05.156403Z","steps":["trace[694840416] 'agreement among raft nodes before linearized reading' (duration: 451.543647ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:05:05.156775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:05:04.704139Z","time spent":"452.615648ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-08T03:05:05.417995Z","caller":"traceutil/trace.go:171","msg":"trace[1378909909] transaction","detail":"{read_only:false; response_revision:25506; number_of_response:1; }","duration":"257.157134ms","start":"2026-07-08T03:05:05.160806Z","end":"2026-07-08T03:05:05.417963Z","steps":["trace[1378909909] 'process raft request' (duration: 183.862622ms)","trace[1378909909] 'compare' (duration: 73.019794ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:05:05.418108Z","caller":"traceutil/trace.go:171","msg":"trace[332994188] transaction","detail":"{read_only:false; response_revision:25507; number_of_response:1; }","duration":"257.242316ms","start":"2026-07-08T03:05:05.160834Z","end":"2026-07-08T03:05:05.418076Z","steps":["trace[332994188] 'process raft request' (duration: 257.054051ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:05:05.418303Z","caller":"traceutil/trace.go:171","msg":"trace[1867138614] linearizableReadLoop","detail":"{readStateIndex:26333; appliedIndex:26330; }","duration":"221.619945ms","start":"2026-07-08T03:05:05.19667Z","end":"2026-07-08T03:05:05.41829Z","steps":["trace[1867138614] 'read index received' (duration: 147.883371ms)","trace[1867138614] 'applied index is now lower than readState.Index' (duration: 73.735984ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:05:05.418304Z","caller":"traceutil/trace.go:171","msg":"trace[91958872] transaction","detail":"{read_only:false; response_revision:25508; number_of_response:1; }","duration":"256.795354ms","start":"2026-07-08T03:05:05.161497Z","end":"2026-07-08T03:05:05.418293Z","steps":["trace[91958872] 'process raft request' (duration: 256.510716ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:05:05.418388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.718227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T03:05:05.418405Z","caller":"traceutil/trace.go:171","msg":"trace[725275642] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25508; }","duration":"221.781129ms","start":"2026-07-08T03:05:05.196618Z","end":"2026-07-08T03:05:05.418399Z","steps":["trace[725275642] 'agreement among raft nodes before linearized reading' (duration: 221.735828ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:05:05.41853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.400296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3309"} {"level":"info","ts":"2026-07-08T03:05:05.418632Z","caller":"traceutil/trace.go:171","msg":"trace[1772746111] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:25508; }","duration":"102.55182ms","start":"2026-07-08T03:05:05.316053Z","end":"2026-07-08T03:05:05.418605Z","steps":["trace[1772746111] 'agreement among raft nodes before linearized reading' (duration: 102.313873ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:05:11.479826Z","caller":"traceutil/trace.go:171","msg":"trace[1202755456] transaction","detail":"{read_only:false; response_revision:25569; number_of_response:1; }","duration":"305.683145ms","start":"2026-07-08T03:05:11.17412Z","end":"2026-07-08T03:05:11.479803Z","steps":["trace[1202755456] 'process raft request' (duration: 305.526261ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:05:11.479979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:05:11.174088Z","time spent":"305.807388ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T03:05:11.585339Z","caller":"traceutil/trace.go:171","msg":"trace[2090311069] transaction","detail":"{read_only:false; response_revision:25570; number_of_response:1; }","duration":"410.332116ms","start":"2026-07-08T03:05:11.174962Z","end":"2026-07-08T03:05:11.585294Z","steps":["trace[2090311069] 'process raft request' (duration: 386.927005ms)","trace[2090311069] 'compare' (duration: 22.984739ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:05:11.585562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:05:11.174953Z","time spent":"410.498661ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T03:05:11.642779Z","caller":"traceutil/trace.go:171","msg":"trace[1566356545] linearizableReadLoop","detail":"{readStateIndex:26396; appliedIndex:26394; }","duration":"465.949341ms","start":"2026-07-08T03:05:11.176799Z","end":"2026-07-08T03:05:11.642748Z","steps":["trace[1566356545] 'read index received' (duration: 302.842694ms)","trace[1566356545] 'applied index is now lower than readState.Index' (duration: 163.105086ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:05:11.642979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.239061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T03:05:11.643012Z","caller":"traceutil/trace.go:171","msg":"trace[1455255416] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25570; }","duration":"449.336704ms","start":"2026-07-08T03:05:11.193666Z","end":"2026-07-08T03:05:11.643003Z","steps":["trace[1455255416] 'agreement among raft nodes before linearized reading' (duration: 449.245731ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:05:11.643024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.546531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-07-08T03:05:11.643046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:05:11.193641Z","time spent":"449.396796ms","remote":"127.0.0.1:60710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-08T03:05:11.643082Z","caller":"traceutil/trace.go:171","msg":"trace[967753715] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:25570; }","duration":"230.666553ms","start":"2026-07-08T03:05:11.4124Z","end":"2026-07-08T03:05:11.643066Z","steps":["trace[967753715] 'agreement among raft nodes before linearized reading' (duration: 230.55928ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:05:11.643089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.542707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-07-08T03:05:11.643138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.41819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-manila-default-user\" ","response":"range_response_count:1 size:1312"} {"level":"warn","ts":"2026-07-08T03:05:11.643148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.28706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-07-08T03:05:11.643213Z","caller":"traceutil/trace.go:171","msg":"trace[1446512177] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-manila-default-user; range_end:; response_count:1; response_revision:25570; }","duration":"190.511463ms","start":"2026-07-08T03:05:11.452679Z","end":"2026-07-08T03:05:11.643191Z","steps":["trace[1446512177] 'agreement among raft nodes before linearized reading' (duration: 190.282787ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:05:11.643196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.949342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-08T03:05:11.643249Z","caller":"traceutil/trace.go:171","msg":"trace[2056512692] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25570; }","duration":"466.469745ms","start":"2026-07-08T03:05:11.176758Z","end":"2026-07-08T03:05:11.643227Z","steps":["trace[2056512692] 'agreement among raft nodes before linearized reading' (duration: 466.146876ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:05:11.643161Z","caller":"traceutil/trace.go:171","msg":"trace[1592583166] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25570; }","duration":"195.63126ms","start":"2026-07-08T03:05:11.447509Z","end":"2026-07-08T03:05:11.64314Z","steps":["trace[1592583166] 'agreement among raft nodes before linearized reading' (duration: 195.418714ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:05:11.643274Z","caller":"traceutil/trace.go:171","msg":"trace[1147648689] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25570; }","duration":"442.082757ms","start":"2026-07-08T03:05:11.201172Z","end":"2026-07-08T03:05:11.643255Z","steps":["trace[1147648689] 'agreement among raft nodes before linearized reading' (duration: 441.85661ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:05:11.643109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.879503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-07-08T03:05:11.643308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:05:11.176748Z","time spent":"466.545897ms","remote":"127.0.0.1:60958","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-07-08T03:05:11.643321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:05:11.201148Z","time spent":"442.160388ms","remote":"127.0.0.1:60958","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":"info","ts":"2026-07-08T03:05:11.643339Z","caller":"traceutil/trace.go:171","msg":"trace[683539207] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25570; }","duration":"198.146291ms","start":"2026-07-08T03:05:11.445182Z","end":"2026-07-08T03:05:11.643328Z","steps":["trace[683539207] 'agreement among raft nodes before linearized reading' (duration: 197.856903ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:05:11.643317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.717102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-07-08T03:05:11.643416Z","caller":"traceutil/trace.go:171","msg":"trace[1857172365] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25570; }","duration":"194.891708ms","start":"2026-07-08T03:05:11.448498Z","end":"2026-07-08T03:05:11.643389Z","steps":["trace[1857172365] 'agreement among raft nodes before linearized reading' (duration: 194.552128ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:05:14.069496Z","caller":"traceutil/trace.go:171","msg":"trace[1807222320] transaction","detail":"{read_only:false; response_revision:25593; number_of_response:1; }","duration":"308.27654ms","start":"2026-07-08T03:05:13.761189Z","end":"2026-07-08T03:05:14.069466Z","steps":["trace[1807222320] 'process raft request' (duration: 308.206778ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:05:14.069573Z","caller":"traceutil/trace.go:171","msg":"trace[1746025357] transaction","detail":"{read_only:false; response_revision:25592; number_of_response:1; }","duration":"308.366572ms","start":"2026-07-08T03:05:13.761159Z","end":"2026-07-08T03:05:14.069526Z","steps":["trace[1746025357] 'process raft request' (duration: 308.198557ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:05:14.069689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:05:13.761182Z","time spent":"308.408313ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T03:05:14.069789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:05:13.76114Z","time spent":"308.527467ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T03:05:14.069898Z","caller":"traceutil/trace.go:171","msg":"trace[1984156689] transaction","detail":"{read_only:false; response_revision:25594; number_of_response:1; }","duration":"307.310631ms","start":"2026-07-08T03:05:13.762578Z","end":"2026-07-08T03:05:14.069889Z","steps":["trace[1984156689] 'process raft request' (duration: 306.846968ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:05:14.069947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:05:13.762569Z","time spent":"307.352723ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T03:05:14.069911Z","caller":"traceutil/trace.go:171","msg":"trace[1989455857] transaction","detail":"{read_only:false; response_revision:25595; number_of_response:1; }","duration":"293.436103ms","start":"2026-07-08T03:05:13.776448Z","end":"2026-07-08T03:05:14.069884Z","steps":["trace[1989455857] 'process raft request' (duration: 293.263958ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:05:14.0702Z","caller":"traceutil/trace.go:171","msg":"trace[283259421] transaction","detail":"{read_only:false; response_revision:25591; number_of_response:1; }","duration":"308.435824ms","start":"2026-07-08T03:05:13.761115Z","end":"2026-07-08T03:05:14.069551Z","steps":["trace[283259421] 'process raft request' (duration: 308.045123ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:05:14.070441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:05:13.761094Z","time spent":"309.241568ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T03:05:24.936315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.104621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:562"} {"level":"info","ts":"2026-07-08T03:05:24.936399Z","caller":"traceutil/trace.go:171","msg":"trace[1745800005] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:25700; }","duration":"114.228314ms","start":"2026-07-08T03:05:24.822151Z","end":"2026-07-08T03:05:24.936379Z","steps":["trace[1745800005] 'range keys from in-memory index tree' (duration: 113.953587ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:05:24.936475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.661478ms","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-07-08T03:05:24.93655Z","caller":"traceutil/trace.go:171","msg":"trace[2110461665] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25700; }","duration":"128.777392ms","start":"2026-07-08T03:05:24.807754Z","end":"2026-07-08T03:05:24.936532Z","steps":["trace[2110461665] 'range keys from in-memory index tree' (duration: 128.581176ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:05:25.076312Z","caller":"traceutil/trace.go:171","msg":"trace[778230892] linearizableReadLoop","detail":"{readStateIndex:26530; appliedIndex:26529; }","duration":"120.868866ms","start":"2026-07-08T03:05:24.955414Z","end":"2026-07-08T03:05:25.076283Z","steps":["trace[778230892] 'read index received' (duration: 120.708211ms)","trace[778230892] 'applied index is now lower than readState.Index' (duration: 159.545µs)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:05:25.07636Z","caller":"traceutil/trace.go:171","msg":"trace[2023905061] transaction","detail":"{read_only:false; response_revision:25701; number_of_response:1; }","duration":"122.012788ms","start":"2026-07-08T03:05:24.95432Z","end":"2026-07-08T03:05:25.076333Z","steps":["trace[2023905061] 'process raft request' (duration: 121.806872ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:05:25.076761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.327689ms","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-07-08T03:05:25.076837Z","caller":"traceutil/trace.go:171","msg":"trace[773083620] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25701; }","duration":"121.443623ms","start":"2026-07-08T03:05:24.955376Z","end":"2026-07-08T03:05:25.07682Z","steps":["trace[773083620] 'agreement among raft nodes before linearized reading' (duration: 121.01839ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:05:25.29574Z","caller":"traceutil/trace.go:171","msg":"trace[1058844046] transaction","detail":"{read_only:false; response_revision:25702; number_of_response:1; }","duration":"314.367984ms","start":"2026-07-08T03:05:24.98135Z","end":"2026-07-08T03:05:25.295718Z","steps":["trace[1058844046] 'process raft request' (duration: 267.894941ms)","trace[1058844046] 'compare' (duration: 46.301108ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:05:25.295903Z","caller":"traceutil/trace.go:171","msg":"trace[972928268] linearizableReadLoop","detail":"{readStateIndex:26532; appliedIndex:26530; }","duration":"216.751046ms","start":"2026-07-08T03:05:25.079122Z","end":"2026-07-08T03:05:25.295873Z","steps":["trace[972928268] 'read index received' (duration: 170.17007ms)","trace[972928268] 'applied index is now lower than readState.Index' (duration: 46.579106ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:05:25.295867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:05:24.981337Z","time spent":"314.466197ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-08T03:05:25.295987Z","caller":"traceutil/trace.go:171","msg":"trace[665984629] transaction","detail":"{read_only:false; response_revision:25703; number_of_response:1; }","duration":"282.436278ms","start":"2026-07-08T03:05:25.013527Z","end":"2026-07-08T03:05:25.295963Z","steps":["trace[665984629] 'process raft request' (duration: 282.12754ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:05:25.296155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.020963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18435"} {"level":"info","ts":"2026-07-08T03:05:25.296222Z","caller":"traceutil/trace.go:171","msg":"trace[840094634] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:25703; }","duration":"217.126056ms","start":"2026-07-08T03:05:25.079081Z","end":"2026-07-08T03:05:25.296207Z","steps":["trace[840094634] 'agreement among raft nodes before linearized reading' (duration: 216.883969ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:05:25.543875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.556959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T03:05:25.543953Z","caller":"traceutil/trace.go:171","msg":"trace[1081406746] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25703; }","duration":"118.698083ms","start":"2026-07-08T03:05:25.42524Z","end":"2026-07-08T03:05:25.543938Z","steps":["trace[1081406746] 'range keys from in-memory index tree' (duration: 118.457097ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:05:29.603195Z","caller":"traceutil/trace.go:171","msg":"trace[1752057983] transaction","detail":"{read_only:false; response_revision:25732; number_of_response:1; }","duration":"219.825283ms","start":"2026-07-08T03:05:29.383338Z","end":"2026-07-08T03:05:29.603163Z","steps":["trace[1752057983] 'process raft request' (duration: 191.858881ms)","trace[1752057983] 'compare' (duration: 27.21574ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:05:29.60321Z","caller":"traceutil/trace.go:171","msg":"trace[942761825] linearizableReadLoop","detail":"{readStateIndex:26562; appliedIndex:26561; }","duration":"160.305316ms","start":"2026-07-08T03:05:29.442858Z","end":"2026-07-08T03:05:29.603164Z","steps":["trace[942761825] 'read index received' (duration: 132.327314ms)","trace[942761825] 'applied index is now lower than readState.Index' (duration: 27.974102ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:05:29.603359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.471351ms","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":"info","ts":"2026-07-08T03:05:29.603444Z","caller":"traceutil/trace.go:171","msg":"trace[138346874] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:25733; }","duration":"160.579824ms","start":"2026-07-08T03:05:29.442844Z","end":"2026-07-08T03:05:29.603424Z","steps":["trace[138346874] 'agreement among raft nodes before linearized reading' (duration: 160.409669ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:05:35.440123Z","caller":"traceutil/trace.go:171","msg":"trace[1263448289] transaction","detail":"{read_only:false; response_revision:25774; number_of_response:1; }","duration":"112.65729ms","start":"2026-07-08T03:05:35.327446Z","end":"2026-07-08T03:05:35.440103Z","steps":["trace[1263448289] 'process raft request' (duration: 112.478375ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:05:35.72222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.801782ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-08T03:05:35.722402Z","caller":"traceutil/trace.go:171","msg":"trace[1811952888] linearizableReadLoop","detail":"{readStateIndex:26606; appliedIndex:26604; }","duration":"295.583556ms","start":"2026-07-08T03:05:35.426776Z","end":"2026-07-08T03:05:35.72236Z","steps":["trace[1811952888] 'read index received' (duration: 13.175958ms)","trace[1811952888] 'applied index is now lower than readState.Index' (duration: 282.405368ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:05:35.722406Z","caller":"traceutil/trace.go:171","msg":"trace[345330218] transaction","detail":"{read_only:false; response_revision:25775; number_of_response:1; }","duration":"391.576338ms","start":"2026-07-08T03:05:35.330797Z","end":"2026-07-08T03:05:35.722373Z","steps":["trace[345330218] 'process raft request' (duration: 246.495578ms)","trace[345330218] 'compare' (duration: 144.592337ms)"],"step_count":2} {"level":"warn","ts":"2026-07-08T03:05:35.722541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-08T03:05:35.330773Z","time spent":"391.698222ms","remote":"127.0.0.1:60958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-08T03:05:35.723049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.258036ms","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-07-08T03:05:35.72318Z","caller":"traceutil/trace.go:171","msg":"trace[1579024909] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25775; }","duration":"296.40154ms","start":"2026-07-08T03:05:35.42676Z","end":"2026-07-08T03:05:35.723161Z","steps":["trace[1579024909] 'agreement among raft nodes before linearized reading' (duration: 295.71684ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:05:35.725971Z","caller":"traceutil/trace.go:171","msg":"trace[665623055] transaction","detail":"{read_only:false; response_revision:25776; number_of_response:1; }","duration":"100.193014ms","start":"2026-07-08T03:05:35.625764Z","end":"2026-07-08T03:05:35.725957Z","steps":["trace[665623055] 'process raft request' (duration: 100.04613ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:05:35.726496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.79076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-08T03:05:35.726616Z","caller":"traceutil/trace.go:171","msg":"trace[2146247216] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25776; }","duration":"297.423848ms","start":"2026-07-08T03:05:35.429175Z","end":"2026-07-08T03:05:35.726599Z","steps":["trace[2146247216] 'agreement among raft nodes before linearized reading' (duration: 296.759059ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:05:39.378388Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-000000000000680b.wal"} {"level":"info","ts":"2026-07-08T03:06:02.544348Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23083} {"level":"info","ts":"2026-07-08T03:06:02.675662Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23083,"took":"127.967259ms","hash":3237082167,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":38182912,"current-db-size-in-use":"38 MB"} {"level":"info","ts":"2026-07-08T03:06:02.675728Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3237082167,"revision":23083,"compact-revision":20170} {"level":"info","ts":"2026-07-08T03:07:06.255652Z","caller":"traceutil/trace.go:171","msg":"trace[2086170707] linearizableReadLoop","detail":"{readStateIndex:27526; appliedIndex:27525; }","duration":"101.272144ms","start":"2026-07-08T03:07:06.154353Z","end":"2026-07-08T03:07:06.255625Z","steps":["trace[2086170707] 'read index received' (duration: 96.739773ms)","trace[2086170707] 'applied index is now lower than readState.Index' (duration: 4.531411ms)"],"step_count":2} {"level":"info","ts":"2026-07-08T03:07:06.255916Z","caller":"traceutil/trace.go:171","msg":"trace[1340592616] transaction","detail":"{read_only:false; response_revision:26674; number_of_response:1; }","duration":"106.810313ms","start":"2026-07-08T03:07:06.149094Z","end":"2026-07-08T03:07:06.255904Z","steps":["trace[1340592616] 'process raft request' (duration: 101.973204ms)"],"step_count":1} {"level":"warn","ts":"2026-07-08T03:07:06.256379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.014425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.153\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-07-08T03:07:06.256433Z","caller":"traceutil/trace.go:171","msg":"trace[1487716091] range","detail":"{range_begin:/registry/masterleases/199.204.45.153; range_end:; response_count:1; response_revision:26674; }","duration":"102.103068ms","start":"2026-07-08T03:07:06.154318Z","end":"2026-07-08T03:07:06.256421Z","steps":["trace[1487716091] 'agreement among raft nodes before linearized reading' (duration: 101.888102ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:07:59.943531Z","caller":"traceutil/trace.go:171","msg":"trace[1025344116] transaction","detail":"{read_only:false; response_revision:27163; number_of_response:1; }","duration":"108.399338ms","start":"2026-07-08T03:07:59.835103Z","end":"2026-07-08T03:07:59.943503Z","steps":["trace[1025344116] 'process raft request' (duration: 108.241074ms)"],"step_count":1} {"level":"info","ts":"2026-07-08T03:11:02.549591Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26129} {"level":"info","ts":"2026-07-08T03:11:02.704468Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26129,"took":"149.801805ms","hash":1639821437,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":35684352,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-07-08T03:11:02.704536Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1639821437,"revision":26129,"compact-revision":23083} {"level":"info","ts":"2026-07-08T03:11:35.364717Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"355195d5aae85944","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-08T03:11:35.369403Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-07-08T03:11:35.369582Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-07-08T03:16:02.556982Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28849} {"level":"info","ts":"2026-07-08T03:16:02.714687Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28849,"took":"154.288603ms","hash":1809022315,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":30748672,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-08T03:16:02.714757Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1809022315,"revision":28849,"compact-revision":26129} {"level":"info","ts":"2026-07-08T03:21:02.562843Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":31068} {"level":"info","ts":"2026-07-08T03:21:02.686412Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":31068,"took":"119.38878ms","hash":1875865565,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":30752768,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-08T03:21:02.686493Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1875865565,"revision":31068,"compact-revision":28849} {"level":"info","ts":"2026-07-08T03:26:02.569173Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33332} {"level":"info","ts":"2026-07-08T03:26:02.713786Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33332,"took":"140.359044ms","hash":924040680,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":32264192,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-07-08T03:26:02.713866Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":924040680,"revision":33332,"compact-revision":31068} {"level":"info","ts":"2026-07-08T03:31:02.575538Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35630} {"level":"info","ts":"2026-07-08T03:31:02.725452Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35630,"took":"145.039212ms","hash":3785808197,"current-db-size-bytes":58740736,"current-db-size":"59 MB","current-db-size-in-use-bytes":31895552,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-07-08T03:31:02.725529Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3785808197,"revision":35630,"compact-revision":33332} {"level":"info","ts":"2026-07-08T03:33:04.664558Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"355195d5aae85944","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-08T03:33:04.669664Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-07-08T03:33:04.669749Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-07-08T03:36:02.582534Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37859} {"level":"info","ts":"2026-07-08T03:36:02.694607Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37859,"took":"107.04876ms","hash":3058896910,"current-db-size-bytes":58740736,"current-db-size":"59 MB","current-db-size-in-use-bytes":31580160,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-07-08T03:36:02.694662Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3058896910,"revision":37859,"compact-revision":35630}