{"level":"warn","ts":"2026-08-04T21:35:49.947788Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-04T21:35:49.947876Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.248: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.248:2380","--initial-cluster=instance=https://199.204.45.248:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.248:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.248: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-08-04T21:35:49.947936Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-04T21:35:49.947946Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-08-04T21:35:49.947967Z","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-08-04T21:35:49.948552Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"]} {"level":"info","ts":"2026-08-04T21:35:49.948649Z","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.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.248: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-08-04T21:35:49.951303Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.361798ms"} {"level":"info","ts":"2026-08-04T21:35:49.955747Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"39582465ceaa2f67","cluster-id":"87fd8ddedde3be45"} {"level":"info","ts":"2026-08-04T21:35:49.955837Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=()"} {"level":"info","ts":"2026-08-04T21:35:49.955861Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 0"} {"level":"info","ts":"2026-08-04T21:35:49.955879Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 39582465ceaa2f67 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-04T21:35:49.955888Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 1"} {"level":"info","ts":"2026-08-04T21:35:49.955927Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"warn","ts":"2026-08-04T21:35:49.960355Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-04T21:35:49.961814Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-04T21:35:49.963122Z","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-08-04T21:35:49.966169Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"39582465ceaa2f67","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-04T21:35:49.966443Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"39582465ceaa2f67","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-04T21:35:49.966652Z","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-08-04T21:35:49.966718Z","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-08-04T21:35:49.966731Z","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-08-04T21:35:49.96734Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"info","ts":"2026-08-04T21:35:49.967496Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","added-peer-id":"39582465ceaa2f67","added-peer-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-08-04T21:35:49.974042Z","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-08-04T21:35:49.974503Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"39582465ceaa2f67","initial-advertise-peer-urls":["https://199.204.45.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-04T21:35:49.974547Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-04T21:35:49.974856Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-08-04T21:35:49.974874Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-08-04T21:35:50.456232Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 is starting a new election at term 1"} {"level":"info","ts":"2026-08-04T21:35:50.45635Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-04T21:35:50.456381Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgPreVoteResp from 39582465ceaa2f67 at term 1"} {"level":"info","ts":"2026-08-04T21:35:50.456404Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became candidate at term 2"} {"level":"info","ts":"2026-08-04T21:35:50.456421Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgVoteResp from 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-08-04T21:35:50.456438Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became leader at term 2"} {"level":"info","ts":"2026-08-04T21:35:50.456456Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 39582465ceaa2f67 elected leader 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-08-04T21:35:50.457344Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T21:35:50.458094Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-04T21:35:50.458111Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"39582465ceaa2f67","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.248:2379]}","request-path":"/0/members/39582465ceaa2f67/attributes","cluster-id":"87fd8ddedde3be45","publish-timeout":"7s"} {"level":"info","ts":"2026-08-04T21:35:50.458379Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-04T21:35:50.45868Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T21:35:50.458816Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T21:35:50.458821Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-04T21:35:50.458854Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T21:35:50.458875Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-04T21:35:50.462211Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.248:2379"} {"level":"info","ts":"2026-08-04T21:35:50.46253Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-04T21:36:32.968012Z","caller":"traceutil/trace.go:171","msg":"trace[2072721226] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"133.265533ms","start":"2026-08-04T21:36:32.834704Z","end":"2026-08-04T21:36:32.96797Z","steps":["trace[2072721226] 'process raft request' (duration: 132.594397ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:36:33.867549Z","caller":"traceutil/trace.go:171","msg":"trace[1050494519] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:653; }","duration":"329.426602ms","start":"2026-08-04T21:36:33.538078Z","end":"2026-08-04T21:36:33.867505Z","steps":["trace[1050494519] 'read index received' (duration: 323.815294ms)","trace[1050494519] 'applied index is now lower than readState.Index' (duration: 5.610678ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:36:33.867721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.633728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-04T21:36:33.867761Z","caller":"traceutil/trace.go:171","msg":"trace[2018947624] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:634; }","duration":"329.7361ms","start":"2026-08-04T21:36:33.538018Z","end":"2026-08-04T21:36:33.867754Z","steps":["trace[2018947624] 'agreement among raft nodes before linearized reading' (duration: 329.592417ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:36:33.867786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:33.537997Z","time spent":"329.783542ms","remote":"127.0.0.1:49070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-04T21:36:33.868064Z","caller":"traceutil/trace.go:171","msg":"trace[38976274] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"406.316432ms","start":"2026-08-04T21:36:33.461714Z","end":"2026-08-04T21:36:33.86803Z","steps":["trace[38976274] 'process raft request' (duration: 400.834277ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:36:33.868674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:33.461693Z","time spent":"406.465506ms","remote":"127.0.0.1:48928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T21:38:11.763215Z","caller":"traceutil/trace.go:171","msg":"trace[1496945147] transaction","detail":"{read_only:false; response_revision:1898; number_of_response:1; }","duration":"256.358622ms","start":"2026-08-04T21:38:11.506823Z","end":"2026-08-04T21:38:11.763182Z","steps":["trace[1496945147] 'process raft request' (duration: 256.021093ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:38:11.763491Z","caller":"traceutil/trace.go:171","msg":"trace[1793512476] transaction","detail":"{read_only:false; response_revision:1899; number_of_response:1; }","duration":"256.34691ms","start":"2026-08-04T21:38:11.507116Z","end":"2026-08-04T21:38:11.763463Z","steps":["trace[1793512476] 'process raft request' (duration: 255.968891ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:38:11.763657Z","caller":"traceutil/trace.go:171","msg":"trace[1062013257] transaction","detail":"{read_only:false; response_revision:1900; number_of_response:1; }","duration":"256.35191ms","start":"2026-08-04T21:38:11.507284Z","end":"2026-08-04T21:38:11.763636Z","steps":["trace[1062013257] 'process raft request' (duration: 255.874069ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:38:11.776762Z","caller":"traceutil/trace.go:171","msg":"trace[261704472] linearizableReadLoop","detail":"{readStateIndex:1972; appliedIndex:1968; }","duration":"128.167261ms","start":"2026-08-04T21:38:11.648566Z","end":"2026-08-04T21:38:11.776733Z","steps":["trace[261704472] 'read index received' (duration: 114.317391ms)","trace[261704472] 'applied index is now lower than readState.Index' (duration: 13.84864ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:38:11.776812Z","caller":"traceutil/trace.go:171","msg":"trace[1557499398] transaction","detail":"{read_only:false; response_revision:1901; number_of_response:1; }","duration":"190.980619ms","start":"2026-08-04T21:38:11.585807Z","end":"2026-08-04T21:38:11.776788Z","steps":["trace[1557499398] 'process raft request' (duration: 190.757104ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:11.777026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.441777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-04T21:38:11.777064Z","caller":"traceutil/trace.go:171","msg":"trace[775226534] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1901; }","duration":"128.55218ms","start":"2026-08-04T21:38:11.648503Z","end":"2026-08-04T21:38:11.777055Z","steps":["trace[775226534] 'agreement among raft nodes before linearized reading' (duration: 128.384796ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:38:11.926181Z","caller":"traceutil/trace.go:171","msg":"trace[898269646] linearizableReadLoop","detail":"{readStateIndex:1973; appliedIndex:1972; }","duration":"128.152251ms","start":"2026-08-04T21:38:11.797997Z","end":"2026-08-04T21:38:11.92615Z","steps":["trace[898269646] 'read index received' (duration: 123.162478ms)","trace[898269646] 'applied index is now lower than readState.Index' (duration: 4.988503ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:38:11.926482Z","caller":"traceutil/trace.go:171","msg":"trace[2040552565] transaction","detail":"{read_only:false; response_revision:1902; number_of_response:1; }","duration":"145.486485ms","start":"2026-08-04T21:38:11.780962Z","end":"2026-08-04T21:38:11.926449Z","steps":["trace[2040552565] 'process raft request' (duration: 140.314418ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:11.926535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.516779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-04T21:38:11.92666Z","caller":"traceutil/trace.go:171","msg":"trace[1844273128] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1902; }","duration":"128.703804ms","start":"2026-08-04T21:38:11.797939Z","end":"2026-08-04T21:38:11.926643Z","steps":["trace[1844273128] 'agreement among raft nodes before linearized reading' (duration: 128.455808ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:38:23.950017Z","caller":"traceutil/trace.go:171","msg":"trace[1279173854] transaction","detail":"{read_only:false; response_revision:2001; number_of_response:1; }","duration":"132.138648ms","start":"2026-08-04T21:38:23.817834Z","end":"2026-08-04T21:38:23.949973Z","steps":["trace[1279173854] 'process raft request' (duration: 131.863511ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:38:24.075855Z","caller":"traceutil/trace.go:171","msg":"trace[1680992480] transaction","detail":"{read_only:false; response_revision:2004; number_of_response:1; }","duration":"106.937409ms","start":"2026-08-04T21:38:23.968889Z","end":"2026-08-04T21:38:24.075826Z","steps":["trace[1680992480] 'process raft request' (duration: 106.827487ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:38:24.075849Z","caller":"traceutil/trace.go:171","msg":"trace[1894907087] transaction","detail":"{read_only:false; response_revision:2003; number_of_response:1; }","duration":"114.839824ms","start":"2026-08-04T21:38:23.960969Z","end":"2026-08-04T21:38:24.075809Z","steps":["trace[1894907087] 'process raft request' (duration: 74.849325ms)","trace[1894907087] 'compare' (duration: 39.728563ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:38:26.413285Z","caller":"traceutil/trace.go:171","msg":"trace[1755590657] transaction","detail":"{read_only:false; response_revision:2018; number_of_response:1; }","duration":"134.689951ms","start":"2026-08-04T21:38:26.278572Z","end":"2026-08-04T21:38:26.413261Z","steps":["trace[1755590657] 'process raft request' (duration: 134.326362ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:38:27.075661Z","caller":"traceutil/trace.go:171","msg":"trace[410545804] transaction","detail":"{read_only:false; response_revision:2030; number_of_response:1; }","duration":"171.989663ms","start":"2026-08-04T21:38:26.903648Z","end":"2026-08-04T21:38:27.075637Z","steps":["trace[410545804] 'process raft request' (duration: 166.077649ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:39:06.53902Z","caller":"traceutil/trace.go:171","msg":"trace[414303334] linearizableReadLoop","detail":"{readStateIndex:2328; appliedIndex:2327; }","duration":"196.30933ms","start":"2026-08-04T21:39:06.342683Z","end":"2026-08-04T21:39:06.538992Z","steps":["trace[414303334] 'read index received' (duration: 196.085435ms)","trace[414303334] 'applied index is now lower than readState.Index' (duration: 222.515µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:39:06.539139Z","caller":"traceutil/trace.go:171","msg":"trace[608784031] transaction","detail":"{read_only:false; response_revision:2245; number_of_response:1; }","duration":"202.673886ms","start":"2026-08-04T21:39:06.336436Z","end":"2026-08-04T21:39:06.53911Z","steps":["trace[608784031] 'process raft request' (duration: 202.396389ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:39:06.539192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.486374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T21:39:06.539273Z","caller":"traceutil/trace.go:171","msg":"trace[1362050234] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:2245; }","duration":"196.620697ms","start":"2026-08-04T21:39:06.342634Z","end":"2026-08-04T21:39:06.539255Z","steps":["trace[1362050234] 'agreement among raft nodes before linearized reading' (duration: 196.487204ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:39:06.839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.1338ms","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":"warn","ts":"2026-08-04T21:39:06.839024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.302448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-04T21:39:06.839089Z","caller":"traceutil/trace.go:171","msg":"trace[1648003130] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2246; }","duration":"159.290643ms","start":"2026-08-04T21:39:06.679778Z","end":"2026-08-04T21:39:06.839068Z","steps":["trace[1648003130] 'count revisions from in-memory index tree' (duration: 159.035127ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:39:06.839107Z","caller":"traceutil/trace.go:171","msg":"trace[1117588236] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2246; }","duration":"169.434011ms","start":"2026-08-04T21:39:06.669655Z","end":"2026-08-04T21:39:06.839089Z","steps":["trace[1117588236] 'range keys from in-memory index tree' (duration: 169.082042ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:39:42.046408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.470815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-08-04T21:39:42.046499Z","caller":"traceutil/trace.go:171","msg":"trace[147545519] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2616; }","duration":"151.607449ms","start":"2026-08-04T21:39:41.894874Z","end":"2026-08-04T21:39:42.046481Z","steps":["trace[147545519] 'range keys from in-memory index tree' (duration: 151.313332ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:40:15.389916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.286244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T21:40:15.390391Z","caller":"traceutil/trace.go:171","msg":"trace[165478055] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2817; }","duration":"112.852967ms","start":"2026-08-04T21:40:15.277515Z","end":"2026-08-04T21:40:15.390368Z","steps":["trace[165478055] 'range keys from in-memory index tree' (duration: 112.121329ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:40:15.837826Z","caller":"traceutil/trace.go:171","msg":"trace[719119691] transaction","detail":"{read_only:false; response_revision:2819; number_of_response:1; }","duration":"174.662688ms","start":"2026-08-04T21:40:15.663135Z","end":"2026-08-04T21:40:15.837797Z","steps":["trace[719119691] 'process raft request' (duration: 174.490803ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:42:46.203231Z","caller":"traceutil/trace.go:171","msg":"trace[93641750] transaction","detail":"{read_only:false; response_revision:3810; number_of_response:1; }","duration":"200.148852ms","start":"2026-08-04T21:42:46.003056Z","end":"2026-08-04T21:42:46.203204Z","steps":["trace[93641750] 'process raft request' (duration: 199.957927ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:44:09.416748Z","caller":"traceutil/trace.go:171","msg":"trace[17553735] linearizableReadLoop","detail":"{readStateIndex:5047; appliedIndex:5046; }","duration":"105.186ms","start":"2026-08-04T21:44:09.311535Z","end":"2026-08-04T21:44:09.416721Z","steps":["trace[17553735] 'read index received' (duration: 28.729664ms)","trace[17553735] 'applied index is now lower than readState.Index' (duration: 76.455335ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:44:09.417134Z","caller":"traceutil/trace.go:171","msg":"trace[1970356855] transaction","detail":"{read_only:false; response_revision:4863; number_of_response:1; }","duration":"113.473683ms","start":"2026-08-04T21:44:09.303643Z","end":"2026-08-04T21:44:09.417116Z","steps":["trace[1970356855] 'process raft request' (duration: 36.559256ms)","trace[1970356855] 'compare' (duration: 76.403735ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:44:09.417437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.885616ms","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-08-04T21:44:09.417475Z","caller":"traceutil/trace.go:171","msg":"trace[1374362774] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:4863; }","duration":"105.967098ms","start":"2026-08-04T21:44:09.311496Z","end":"2026-08-04T21:44:09.417463Z","steps":["trace[1374362774] 'agreement among raft nodes before linearized reading' (duration: 105.831035ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:44:11.418042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.683442ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T21:44:11.418171Z","caller":"traceutil/trace.go:171","msg":"trace[173445309] linearizableReadLoop","detail":"{readStateIndex:5168; appliedIndex:5167; }","duration":"139.925711ms","start":"2026-08-04T21:44:11.278229Z","end":"2026-08-04T21:44:11.418155Z","steps":["trace[173445309] 'read index received' (duration: 2.822609ms)","trace[173445309] 'applied index is now lower than readState.Index' (duration: 137.101862ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:44:11.418438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.203228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0420eee7-5865-489e-a345-e33f617a5e2c\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-08-04T21:44:11.41853Z","caller":"traceutil/trace.go:171","msg":"trace[1880141889] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0420eee7-5865-489e-a345-e33f617a5e2c; range_end:; response_count:1; response_revision:4982; }","duration":"140.344191ms","start":"2026-08-04T21:44:11.278169Z","end":"2026-08-04T21:44:11.418513Z","steps":["trace[1880141889] 'agreement among raft nodes before linearized reading' (duration: 140.093095ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:44:11.419124Z","caller":"traceutil/trace.go:171","msg":"trace[679347347] transaction","detail":"{read_only:false; response_revision:4982; number_of_response:1; }","duration":"224.074204ms","start":"2026-08-04T21:44:11.19411Z","end":"2026-08-04T21:44:11.418184Z","steps":["trace[679347347] 'process raft request' (duration: 87.002133ms)","trace[679347347] 'compare' (duration: 136.533798ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:44:11.454055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.166233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-m4868.18c8b842c9c5350e\" ","response":"range_response_count:1 size:962"} {"level":"info","ts":"2026-08-04T21:44:11.454138Z","caller":"traceutil/trace.go:171","msg":"trace[241348912] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-m4868.18c8b842c9c5350e; range_end:; response_count:1; response_revision:4983; }","duration":"172.290575ms","start":"2026-08-04T21:44:11.281826Z","end":"2026-08-04T21:44:11.454117Z","steps":["trace[241348912] 'agreement among raft nodes before linearized reading' (duration: 172.070529ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:44:13.689867Z","caller":"traceutil/trace.go:171","msg":"trace[657520682] transaction","detail":"{read_only:false; response_revision:5017; number_of_response:1; }","duration":"104.209866ms","start":"2026-08-04T21:44:13.585628Z","end":"2026-08-04T21:44:13.689838Z","steps":["trace[657520682] 'process raft request' (duration: 104.020471ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:44:24.537224Z","caller":"traceutil/trace.go:171","msg":"trace[284553977] transaction","detail":"{read_only:false; response_revision:5240; number_of_response:1; }","duration":"106.138843ms","start":"2026-08-04T21:44:24.431056Z","end":"2026-08-04T21:44:24.537194Z","steps":["trace[284553977] 'process raft request' (duration: 60.610347ms)","trace[284553977] 'compare' (duration: 45.329991ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:44:24.888019Z","caller":"traceutil/trace.go:171","msg":"trace[1637682949] linearizableReadLoop","detail":"{readStateIndex:5441; appliedIndex:5440; }","duration":"130.09827ms","start":"2026-08-04T21:44:24.757896Z","end":"2026-08-04T21:44:24.887994Z","steps":["trace[1637682949] 'read index received' (duration: 129.874785ms)","trace[1637682949] 'applied index is now lower than readState.Index' (duration: 222.425µs)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:44:24.888394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.477349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-08-04T21:44:24.88848Z","caller":"traceutil/trace.go:171","msg":"trace[319363284] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5246; }","duration":"130.620362ms","start":"2026-08-04T21:44:24.757842Z","end":"2026-08-04T21:44:24.888463Z","steps":["trace[319363284] 'agreement among raft nodes before linearized reading' (duration: 130.360146ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:44:24.888692Z","caller":"traceutil/trace.go:171","msg":"trace[1739533288] transaction","detail":"{read_only:false; response_revision:5246; number_of_response:1; }","duration":"144.832961ms","start":"2026-08-04T21:44:24.743843Z","end":"2026-08-04T21:44:24.888676Z","steps":["trace[1739533288] 'process raft request' (duration: 144.00269ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:44:32.211911Z","caller":"traceutil/trace.go:171","msg":"trace[1030444877] linearizableReadLoop","detail":"{readStateIndex:5613; appliedIndex:5611; }","duration":"155.376971ms","start":"2026-08-04T21:44:32.05651Z","end":"2026-08-04T21:44:32.211887Z","steps":["trace[1030444877] 'read index received' (duration: 155.045003ms)","trace[1030444877] 'applied index is now lower than readState.Index' (duration: 331.058µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:44:32.211951Z","caller":"traceutil/trace.go:171","msg":"trace[20054595] transaction","detail":"{read_only:false; response_revision:5413; number_of_response:1; }","duration":"209.632781ms","start":"2026-08-04T21:44:32.002286Z","end":"2026-08-04T21:44:32.211919Z","steps":["trace[20054595] 'process raft request' (duration: 209.337484ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:44:32.212028Z","caller":"traceutil/trace.go:171","msg":"trace[968043332] transaction","detail":"{read_only:false; response_revision:5414; number_of_response:1; }","duration":"198.172791ms","start":"2026-08-04T21:44:32.013815Z","end":"2026-08-04T21:44:32.211988Z","steps":["trace[968043332] 'process raft request' (duration: 197.992506ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:44:32.21222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.682698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1ed56484-fe3e-4e6e-b9e2-a48c093e84a4\" ","response":"range_response_count:1 size:3646"} {"level":"warn","ts":"2026-08-04T21:44:32.212213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.499144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T21:44:32.212288Z","caller":"traceutil/trace.go:171","msg":"trace[912238032] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1ed56484-fe3e-4e6e-b9e2-a48c093e84a4; range_end:; response_count:1; response_revision:5414; }","duration":"155.805692ms","start":"2026-08-04T21:44:32.056465Z","end":"2026-08-04T21:44:32.212271Z","steps":["trace[912238032] 'agreement among raft nodes before linearized reading' (duration: 155.568886ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:44:32.212309Z","caller":"traceutil/trace.go:171","msg":"trace[2125365672] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:5414; }","duration":"142.631138ms","start":"2026-08-04T21:44:32.069653Z","end":"2026-08-04T21:44:32.212284Z","steps":["trace[2125365672] 'agreement among raft nodes before linearized reading' (duration: 142.456984ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:44:32.674703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.531806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1ed56484-fe3e-4e6e-b9e2-a48c093e84a4\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-08-04T21:44:32.674793Z","caller":"traceutil/trace.go:171","msg":"trace[451538814] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1ed56484-fe3e-4e6e-b9e2-a48c093e84a4; range_end:; response_count:1; response_revision:5415; }","duration":"160.67013ms","start":"2026-08-04T21:44:32.514104Z","end":"2026-08-04T21:44:32.674774Z","steps":["trace[451538814] 'range keys from in-memory index tree' (duration: 160.323512ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:45:50.499255Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3009} {"level":"info","ts":"2026-08-04T21:45:50.576555Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3009,"took":"75.81038ms","hash":2545411222,"current-db-size-bytes":58634240,"current-db-size":"59 MB","current-db-size-in-use-bytes":31916032,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-08-04T21:45:50.576709Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2545411222,"revision":3009,"compact-revision":-1} {"level":"info","ts":"2026-08-04T21:50:50.505933Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6114} {"level":"info","ts":"2026-08-04T21:50:50.607793Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6114,"took":"99.771727ms","hash":461267011,"current-db-size-bytes":58634240,"current-db-size":"59 MB","current-db-size-in-use-bytes":23347200,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-08-04T21:50:50.607887Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":461267011,"revision":6114,"compact-revision":3009} {"level":"info","ts":"2026-08-04T21:50:53.280683Z","caller":"traceutil/trace.go:171","msg":"trace[1771072678] transaction","detail":"{read_only:false; response_revision:8314; number_of_response:1; }","duration":"141.302912ms","start":"2026-08-04T21:50:53.139357Z","end":"2026-08-04T21:50:53.28066Z","steps":["trace[1771072678] 'process raft request' (duration: 140.933013ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:50:53.39758Z","caller":"traceutil/trace.go:171","msg":"trace[1198104988] linearizableReadLoop","detail":"{readStateIndex:8606; appliedIndex:8604; }","duration":"111.887022ms","start":"2026-08-04T21:50:53.285669Z","end":"2026-08-04T21:50:53.397556Z","steps":["trace[1198104988] 'read index received' (duration: 107.795933ms)","trace[1198104988] 'applied index is now lower than readState.Index' (duration: 4.089709ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:50:53.397635Z","caller":"traceutil/trace.go:171","msg":"trace[647065150] transaction","detail":"{read_only:false; response_revision:8315; number_of_response:1; }","duration":"113.113313ms","start":"2026-08-04T21:50:53.284481Z","end":"2026-08-04T21:50:53.397594Z","steps":["trace[647065150] 'process raft request' (duration: 108.922901ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:50:53.397693Z","caller":"traceutil/trace.go:171","msg":"trace[552023319] transaction","detail":"{read_only:false; response_revision:8316; number_of_response:1; }","duration":"112.547251ms","start":"2026-08-04T21:50:53.285105Z","end":"2026-08-04T21:50:53.397652Z","steps":["trace[552023319] 'process raft request' (duration: 112.403216ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:50:53.39801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.323043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:25 size:224171"} {"level":"info","ts":"2026-08-04T21:50:53.398078Z","caller":"traceutil/trace.go:171","msg":"trace[548738832] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:25; response_revision:8316; }","duration":"112.407686ms","start":"2026-08-04T21:50:53.285658Z","end":"2026-08-04T21:50:53.398066Z","steps":["trace[548738832] 'agreement among raft nodes before linearized reading' (duration: 111.992356ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:51:08.566012Z","caller":"traceutil/trace.go:171","msg":"trace[1512635701] linearizableReadLoop","detail":"{readStateIndex:8687; appliedIndex:8686; }","duration":"163.20384ms","start":"2026-08-04T21:51:08.402778Z","end":"2026-08-04T21:51:08.565982Z","steps":["trace[1512635701] 'read index received' (duration: 85.536037ms)","trace[1512635701] 'applied index is now lower than readState.Index' (duration: 77.666302ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:51:08.566111Z","caller":"traceutil/trace.go:171","msg":"trace[777480379] transaction","detail":"{read_only:false; response_revision:8394; number_of_response:1; }","duration":"166.658041ms","start":"2026-08-04T21:51:08.399418Z","end":"2026-08-04T21:51:08.566077Z","steps":["trace[777480379] 'process raft request' (duration: 88.915037ms)","trace[777480379] 'compare' (duration: 77.503168ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:51:08.566336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.535778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-08-04T21:51:08.566434Z","caller":"traceutil/trace.go:171","msg":"trace[1864309172] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:8394; }","duration":"163.68117ms","start":"2026-08-04T21:51:08.402729Z","end":"2026-08-04T21:51:08.56641Z","steps":["trace[1864309172] 'agreement among raft nodes before linearized reading' (duration: 163.349573ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:51:09.41177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.165786ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-04T21:51:09.411903Z","caller":"traceutil/trace.go:171","msg":"trace[993414475] linearizableReadLoop","detail":"{readStateIndex:8693; appliedIndex:8692; }","duration":"316.782824ms","start":"2026-08-04T21:51:09.095088Z","end":"2026-08-04T21:51:09.411871Z","steps":["trace[993414475] 'read index received' (duration: 65.510965ms)","trace[993414475] 'applied index is now lower than readState.Index' (duration: 251.270119ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:51:09.412023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.904176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T21:51:09.412087Z","caller":"traceutil/trace.go:171","msg":"trace[411821283] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:8399; }","duration":"317.014779ms","start":"2026-08-04T21:51:09.095055Z","end":"2026-08-04T21:51:09.412069Z","steps":["trace[411821283] 'agreement among raft nodes before linearized reading' (duration: 316.891996ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:51:09.412138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:51:09.09504Z","time spent":"317.088041ms","remote":"127.0.0.1:35878","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true "} {"level":"warn","ts":"2026-08-04T21:51:09.444125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.311175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T21:51:09.444172Z","caller":"traceutil/trace.go:171","msg":"trace[1033004758] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8400; }","duration":"166.404007ms","start":"2026-08-04T21:51:09.277754Z","end":"2026-08-04T21:51:09.444158Z","steps":["trace[1033004758] 'agreement among raft nodes before linearized reading' (duration: 166.325845ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:51:09.444218Z","caller":"traceutil/trace.go:171","msg":"trace[1549631634] transaction","detail":"{read_only:false; response_revision:8400; number_of_response:1; }","duration":"110.330414ms","start":"2026-08-04T21:51:09.333816Z","end":"2026-08-04T21:51:09.444146Z","steps":["trace[1549631634] 'process raft request' (duration: 110.113259ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:51:10.523908Z","caller":"traceutil/trace.go:171","msg":"trace[1635211435] transaction","detail":"{read_only:false; response_revision:8407; number_of_response:1; }","duration":"122.952221ms","start":"2026-08-04T21:51:10.40093Z","end":"2026-08-04T21:51:10.523882Z","steps":["trace[1635211435] 'process raft request' (duration: 122.670314ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:51:23.607224Z","caller":"traceutil/trace.go:171","msg":"trace[2089616536] linearizableReadLoop","detail":"{readStateIndex:8828; appliedIndex:8827; }","duration":"518.933643ms","start":"2026-08-04T21:51:23.088259Z","end":"2026-08-04T21:51:23.607193Z","steps":["trace[2089616536] 'read index received' (duration: 498.344477ms)","trace[2089616536] 'applied index is now lower than readState.Index' (duration: 20.587806ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:51:23.607415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.128057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T21:51:23.607443Z","caller":"traceutil/trace.go:171","msg":"trace[1859662837] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:8530; }","duration":"519.222229ms","start":"2026-08-04T21:51:23.088211Z","end":"2026-08-04T21:51:23.607434Z","steps":["trace[1859662837] 'agreement among raft nodes before linearized reading' (duration: 519.121167ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:51:23.607473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:51:23.088166Z","time spent":"519.299521ms","remote":"127.0.0.1:49166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "} {"level":"warn","ts":"2026-08-04T21:51:23.607835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.064934ms","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-08-04T21:51:23.607883Z","caller":"traceutil/trace.go:171","msg":"trace[1577858009] transaction","detail":"{read_only:false; response_revision:8530; number_of_response:1; }","duration":"539.930089ms","start":"2026-08-04T21:51:23.06792Z","end":"2026-08-04T21:51:23.60785Z","steps":["trace[1577858009] 'process raft request' (duration: 518.724008ms)","trace[1577858009] 'compare' (duration: 20.014152ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:51:23.607927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.344413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-04T21:51:23.607928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.510114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T21:51:23.607946Z","caller":"traceutil/trace.go:171","msg":"trace[824500167] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8531; }","duration":"482.207748ms","start":"2026-08-04T21:51:23.125708Z","end":"2026-08-04T21:51:23.607915Z","steps":["trace[824500167] 'agreement among raft nodes before linearized reading' (duration: 481.93815ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:51:23.608013Z","caller":"traceutil/trace.go:171","msg":"trace[1134761231] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:8531; }","duration":"480.445355ms","start":"2026-08-04T21:51:23.127527Z","end":"2026-08-04T21:51:23.607972Z","steps":["trace[1134761231] 'agreement among raft nodes before linearized reading' (duration: 480.321872ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:51:23.608023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:51:23.06791Z","time spent":"540.015691ms","remote":"127.0.0.1:49070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T21:51:23.607972Z","caller":"traceutil/trace.go:171","msg":"trace[777207095] transaction","detail":"{read_only:false; response_revision:8531; number_of_response:1; }","duration":"113.827296ms","start":"2026-08-04T21:51:23.494086Z","end":"2026-08-04T21:51:23.607913Z","steps":["trace[777207095] 'process raft request' (duration: 113.458417ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:51:23.608031Z","caller":"traceutil/trace.go:171","msg":"trace[317950569] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8531; }","duration":"329.661798ms","start":"2026-08-04T21:51:23.278352Z","end":"2026-08-04T21:51:23.608013Z","steps":["trace[317950569] 'agreement among raft nodes before linearized reading' (duration: 329.496214ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:51:23.608056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:51:23.127506Z","time spent":"480.540498ms","remote":"127.0.0.1:38308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true "} {"level":"warn","ts":"2026-08-04T21:51:23.608103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:51:23.278327Z","time spent":"329.767801ms","remote":"127.0.0.1:48842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-04T21:51:23.608008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:51:23.12569Z","time spent":"482.304699ms","remote":"127.0.0.1:49070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-04T21:51:26.906891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.704845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-04T21:51:26.907001Z","caller":"traceutil/trace.go:171","msg":"trace[1778579599] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:8549; }","duration":"147.884369ms","start":"2026-08-04T21:51:26.75909Z","end":"2026-08-04T21:51:26.906974Z","steps":["trace[1778579599] 'count revisions from in-memory index tree' (duration: 147.583291ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:51:26.907339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.247426ms","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-08-04T21:51:26.907419Z","caller":"traceutil/trace.go:171","msg":"trace[1794435356] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8549; }","duration":"223.374489ms","start":"2026-08-04T21:51:26.684025Z","end":"2026-08-04T21:51:26.907399Z","steps":["trace[1794435356] 'range keys from in-memory index tree' (duration: 223.069451ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:51:27.78693Z","caller":"traceutil/trace.go:171","msg":"trace[1987342462] transaction","detail":"{read_only:false; response_revision:8553; number_of_response:1; }","duration":"165.295049ms","start":"2026-08-04T21:51:27.621611Z","end":"2026-08-04T21:51:27.786906Z","steps":["trace[1987342462] 'process raft request' (duration: 165.155846ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:51:27.786982Z","caller":"traceutil/trace.go:171","msg":"trace[1054445816] linearizableReadLoop","detail":"{readStateIndex:8852; appliedIndex:8852; }","duration":"162.962874ms","start":"2026-08-04T21:51:27.623988Z","end":"2026-08-04T21:51:27.786951Z","steps":["trace[1054445816] 'read index received' (duration: 162.949904ms)","trace[1054445816] 'applied index is now lower than readState.Index' (duration: 10.46µs)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:51:27.787301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.290732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-08-04T21:51:27.787372Z","caller":"traceutil/trace.go:171","msg":"trace[1485515900] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8553; }","duration":"163.417146ms","start":"2026-08-04T21:51:27.623939Z","end":"2026-08-04T21:51:27.787356Z","steps":["trace[1485515900] 'agreement among raft nodes before linearized reading' (duration: 163.147399ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:51:27.809924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.065268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-08-04T21:51:27.810032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.704068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-fxrwt\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-08-04T21:51:27.810061Z","caller":"traceutil/trace.go:171","msg":"trace[1685207759] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8554; }","duration":"135.229501ms","start":"2026-08-04T21:51:27.674808Z","end":"2026-08-04T21:51:27.810038Z","steps":["trace[1685207759] 'agreement among raft nodes before linearized reading' (duration: 135.012026ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:51:27.81009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.171708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-08-04T21:51:27.810117Z","caller":"traceutil/trace.go:171","msg":"trace[161399462] range","detail":"{range_begin:/registry/pods/openstack/keepalived-fxrwt; range_end:; response_count:1; response_revision:8554; }","duration":"120.830241ms","start":"2026-08-04T21:51:27.689265Z","end":"2026-08-04T21:51:27.810096Z","steps":["trace[161399462] 'agreement among raft nodes before linearized reading' (duration: 120.551555ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:51:27.810141Z","caller":"traceutil/trace.go:171","msg":"trace[1461234844] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8554; }","duration":"182.249049ms","start":"2026-08-04T21:51:27.627879Z","end":"2026-08-04T21:51:27.810128Z","steps":["trace[1461234844] 'agreement among raft nodes before linearized reading' (duration: 182.004914ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:51:37.944113Z","caller":"traceutil/trace.go:171","msg":"trace[1686870994] transaction","detail":"{read_only:false; response_revision:8650; number_of_response:1; }","duration":"123.897893ms","start":"2026-08-04T21:51:37.820187Z","end":"2026-08-04T21:51:37.944085Z","steps":["trace[1686870994] 'process raft request' (duration: 123.682998ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:51:37.952434Z","caller":"traceutil/trace.go:171","msg":"trace[663286633] transaction","detail":"{read_only:false; response_revision:8651; number_of_response:1; }","duration":"104.390882ms","start":"2026-08-04T21:51:37.848024Z","end":"2026-08-04T21:51:37.952415Z","steps":["trace[663286633] 'process raft request' (duration: 104.247089ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:52:15.763578Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000246b.wal"} {"level":"info","ts":"2026-08-04T21:52:51.13736Z","caller":"traceutil/trace.go:171","msg":"trace[1438344827] transaction","detail":"{read_only:false; response_revision:9385; number_of_response:1; }","duration":"108.347891ms","start":"2026-08-04T21:52:51.028993Z","end":"2026-08-04T21:52:51.137341Z","steps":["trace[1438344827] 'process raft request' (duration: 108.164737ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:52:57.375629Z","caller":"traceutil/trace.go:171","msg":"trace[917965449] transaction","detail":"{read_only:false; response_revision:9420; number_of_response:1; }","duration":"215.914792ms","start":"2026-08-04T21:52:57.159681Z","end":"2026-08-04T21:52:57.375596Z","steps":["trace[917965449] 'process raft request' (duration: 215.702077ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:52:57.58543Z","caller":"traceutil/trace.go:171","msg":"trace[1900556428] transaction","detail":"{read_only:false; response_revision:9422; number_of_response:1; }","duration":"144.305226ms","start":"2026-08-04T21:52:57.441098Z","end":"2026-08-04T21:52:57.585403Z","steps":["trace[1900556428] 'process raft request' (duration: 144.016749ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:53:33.486074Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"39582465ceaa2f67","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-04T21:53:33.491267Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-08-04T21:53:33.491346Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-08-04T21:55:50.51705Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8300} {"level":"info","ts":"2026-08-04T21:55:50.596228Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8300,"took":"76.922424ms","hash":565011945,"current-db-size-bytes":58634240,"current-db-size":"59 MB","current-db-size-in-use-bytes":24092672,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-08-04T21:55:50.596286Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":565011945,"revision":8300,"compact-revision":6114} {"level":"info","ts":"2026-08-04T21:57:12.331533Z","caller":"traceutil/trace.go:171","msg":"trace[2952077] transaction","detail":"{read_only:false; response_revision:11057; number_of_response:1; }","duration":"170.845052ms","start":"2026-08-04T21:57:12.160663Z","end":"2026-08-04T21:57:12.331508Z","steps":["trace[2952077] 'process raft request' (duration: 170.648276ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:57:12.390728Z","caller":"traceutil/trace.go:171","msg":"trace[409205388] linearizableReadLoop","detail":"{readStateIndex:11442; appliedIndex:11440; }","duration":"111.304712ms","start":"2026-08-04T21:57:12.279401Z","end":"2026-08-04T21:57:12.390706Z","steps":["trace[409205388] 'read index received' (duration: 51.904034ms)","trace[409205388] 'applied index is now lower than readState.Index' (duration: 59.399998ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:57:12.390819Z","caller":"traceutil/trace.go:171","msg":"trace[966416897] transaction","detail":"{read_only:false; response_revision:11058; number_of_response:1; }","duration":"228.969068ms","start":"2026-08-04T21:57:12.161811Z","end":"2026-08-04T21:57:12.39078Z","steps":["trace[966416897] 'process raft request' (duration: 228.734802ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:57:12.39086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.447055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T21:57:12.391026Z","caller":"traceutil/trace.go:171","msg":"trace[812909375] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:11058; }","duration":"111.66986ms","start":"2026-08-04T21:57:12.279343Z","end":"2026-08-04T21:57:12.391013Z","steps":["trace[812909375] 'agreement among raft nodes before linearized reading' (duration: 111.469545ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:57:12.626266Z","caller":"traceutil/trace.go:171","msg":"trace[487686319] transaction","detail":"{read_only:false; response_revision:11061; number_of_response:1; }","duration":"126.85062ms","start":"2026-08-04T21:57:12.499389Z","end":"2026-08-04T21:57:12.62624Z","steps":["trace[487686319] 'process raft request' (duration: 126.704637ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:00:50.524273Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10527} {"level":"info","ts":"2026-08-04T22:00:50.603727Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10527,"took":"76.054203ms","hash":3641385463,"current-db-size-bytes":58634240,"current-db-size":"59 MB","current-db-size-in-use-bytes":25985024,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-08-04T22:00:50.603826Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3641385463,"revision":10527,"compact-revision":8300} {"level":"info","ts":"2026-08-04T22:04:22.936755Z","caller":"traceutil/trace.go:171","msg":"trace[1804264068] transaction","detail":"{read_only:false; response_revision:14185; number_of_response:1; }","duration":"106.575927ms","start":"2026-08-04T22:04:22.830148Z","end":"2026-08-04T22:04:22.936724Z","steps":["trace[1804264068] 'compare' (duration: 97.086135ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:04:44.641544Z","caller":"traceutil/trace.go:171","msg":"trace[46794117] transaction","detail":"{read_only:false; response_revision:14338; number_of_response:1; }","duration":"112.053079ms","start":"2026-08-04T22:04:44.529465Z","end":"2026-08-04T22:04:44.641518Z","steps":["trace[46794117] 'process raft request' (duration: 111.868365ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:05:03.329153Z","caller":"traceutil/trace.go:171","msg":"trace[1175553181] transaction","detail":"{read_only:false; response_revision:14455; number_of_response:1; }","duration":"164.506878ms","start":"2026-08-04T22:05:03.164616Z","end":"2026-08-04T22:05:03.329123Z","steps":["trace[1175553181] 'process raft request' (duration: 164.345594ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:05:03.528305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.120648ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T22:05:03.528612Z","caller":"traceutil/trace.go:171","msg":"trace[77513533] transaction","detail":"{read_only:false; response_revision:14457; number_of_response:1; }","duration":"230.157197ms","start":"2026-08-04T22:05:03.298406Z","end":"2026-08-04T22:05:03.528563Z","steps":["trace[77513533] 'process raft request' (duration: 230.023414ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:05:03.52876Z","caller":"traceutil/trace.go:171","msg":"trace[1347205484] transaction","detail":"{read_only:false; response_revision:14456; number_of_response:1; }","duration":"236.360268ms","start":"2026-08-04T22:05:03.292276Z","end":"2026-08-04T22:05:03.528637Z","steps":["trace[1347205484] 'process raft request' (duration: 94.784159ms)","trace[1347205484] 'compare' (duration: 140.941664ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T22:05:03.809178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.636808ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T22:05:03.809302Z","caller":"traceutil/trace.go:171","msg":"trace[1356635887] linearizableReadLoop","detail":"{readStateIndex:14953; appliedIndex:14952; }","duration":"192.814948ms","start":"2026-08-04T22:05:03.616471Z","end":"2026-08-04T22:05:03.809286Z","steps":["trace[1356635887] 'read index received' (duration: 46.913963ms)","trace[1356635887] 'applied index is now lower than readState.Index' (duration: 145.900045ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:05:03.809423Z","caller":"traceutil/trace.go:171","msg":"trace[438349668] transaction","detail":"{read_only:false; response_revision:14459; number_of_response:1; }","duration":"194.865188ms","start":"2026-08-04T22:05:03.614514Z","end":"2026-08-04T22:05:03.809379Z","steps":["trace[438349668] 'process raft request' (duration: 48.918872ms)","trace[438349668] 'compare' (duration: 145.488035ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T22:05:03.809485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.51829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/kube-system/kube-prometheus-stack-kubelet\" ","response":"range_response_count:1 size:684"} {"level":"info","ts":"2026-08-04T22:05:03.809508Z","caller":"traceutil/trace.go:171","msg":"trace[99776934] range","detail":"{range_begin:/registry/services/endpoints/kube-system/kube-prometheus-stack-kubelet; range_end:; response_count:1; response_revision:14459; }","duration":"192.557602ms","start":"2026-08-04T22:05:03.616941Z","end":"2026-08-04T22:05:03.809499Z","steps":["trace[99776934] 'agreement among raft nodes before linearized reading' (duration: 192.435499ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:05:03.80958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.094894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18957"} {"level":"info","ts":"2026-08-04T22:05:03.809637Z","caller":"traceutil/trace.go:171","msg":"trace[1800746934] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:14459; }","duration":"193.199927ms","start":"2026-08-04T22:05:03.616424Z","end":"2026-08-04T22:05:03.809624Z","steps":["trace[1800746934] 'agreement among raft nodes before linearized reading' (duration: 192.996192ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:05:05.342356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.691409ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T22:05:05.3427Z","caller":"traceutil/trace.go:171","msg":"trace[1535955822] transaction","detail":"{read_only:false; response_revision:14469; number_of_response:1; }","duration":"139.98571ms","start":"2026-08-04T22:05:05.202669Z","end":"2026-08-04T22:05:05.342655Z","steps":["trace[1535955822] 'process raft request' (duration: 23.900953ms)","trace[1535955822] 'compare' (duration: 115.38077ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T22:05:22.400312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.326677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-j86k7\" ","response":"range_response_count:1 size:12364"} {"level":"info","ts":"2026-08-04T22:05:22.400413Z","caller":"traceutil/trace.go:171","msg":"trace[335982676] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-j86k7; range_end:; response_count:1; response_revision:14584; }","duration":"220.473781ms","start":"2026-08-04T22:05:22.179915Z","end":"2026-08-04T22:05:22.400389Z","steps":["trace[335982676] 'range keys from in-memory index tree' (duration: 220.162444ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:05:22.400458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.806416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T22:05:22.400554Z","caller":"traceutil/trace.go:171","msg":"trace[763788492] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14584; }","duration":"121.94566ms","start":"2026-08-04T22:05:22.27857Z","end":"2026-08-04T22:05:22.400515Z","steps":["trace[763788492] 'range keys from in-memory index tree' (duration: 121.643733ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:05:22.962415Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415874552520725755,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-04T22:05:23.194933Z","caller":"traceutil/trace.go:171","msg":"trace[158727055] transaction","detail":"{read_only:false; response_revision:14585; number_of_response:1; }","duration":"782.77138ms","start":"2026-08-04T22:05:22.412123Z","end":"2026-08-04T22:05:23.194895Z","steps":["trace[158727055] 'process raft request' (duration: 782.543304ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:05:23.19514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:05:22.412091Z","time spent":"782.939454ms","remote":"127.0.0.1:49004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12483,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T22:05:23.240671Z","caller":"traceutil/trace.go:171","msg":"trace[554964785] transaction","detail":"{read_only:false; response_revision:14586; number_of_response:1; }","duration":"665.626956ms","start":"2026-08-04T22:05:22.57501Z","end":"2026-08-04T22:05:23.240637Z","steps":["trace[554964785] 'process raft request' (duration: 653.641114ms)","trace[554964785] 'compare' (duration: 11.761296ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:05:23.240905Z","caller":"traceutil/trace.go:171","msg":"trace[277245730] linearizableReadLoop","detail":"{readStateIndex:15087; appliedIndex:15085; }","duration":"786.05181ms","start":"2026-08-04T22:05:22.454805Z","end":"2026-08-04T22:05:23.240857Z","steps":["trace[277245730] 'read index received' (duration: 740.398358ms)","trace[277245730] 'applied index is now lower than readState.Index' (duration: 45.649872ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T22:05:23.240863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:05:22.574979Z","time spent":"665.78994ms","remote":"127.0.0.1:49070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T22:05:23.241235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"786.392268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-fxrwt\" ","response":"range_response_count:1 size:6530"} {"level":"warn","ts":"2026-08-04T22:05:23.2413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.530785ms","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-08-04T22:05:23.241332Z","caller":"traceutil/trace.go:171","msg":"trace[330337398] range","detail":"{range_begin:/registry/pods/openstack/keepalived-fxrwt; range_end:; response_count:1; response_revision:14587; }","duration":"786.544182ms","start":"2026-08-04T22:05:22.454764Z","end":"2026-08-04T22:05:23.241308Z","steps":["trace[330337398] 'agreement among raft nodes before linearized reading' (duration: 786.227044ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:05:23.241347Z","caller":"traceutil/trace.go:171","msg":"trace[1983335684] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:14587; }","duration":"184.67421ms","start":"2026-08-04T22:05:23.056658Z","end":"2026-08-04T22:05:23.241332Z","steps":["trace[1983335684] 'agreement among raft nodes before linearized reading' (duration: 184.410713ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:05:23.241388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:05:22.454742Z","time spent":"786.637444ms","remote":"127.0.0.1:49004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6553,"request content":"key:\"/registry/pods/openstack/keepalived-fxrwt\" "} {"level":"info","ts":"2026-08-04T22:05:23.241811Z","caller":"traceutil/trace.go:171","msg":"trace[1982879117] transaction","detail":"{read_only:false; response_revision:14587; number_of_response:1; }","duration":"438.283426ms","start":"2026-08-04T22:05:22.803463Z","end":"2026-08-04T22:05:23.241746Z","steps":["trace[1982879117] 'process raft request' (duration: 437.106208ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:05:23.242039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:05:22.803432Z","time spent":"438.489032ms","remote":"127.0.0.1:49070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T22:05:24.357408Z","caller":"traceutil/trace.go:171","msg":"trace[1520534671] transaction","detail":"{read_only:false; response_revision:14597; number_of_response:1; }","duration":"113.360832ms","start":"2026-08-04T22:05:24.244007Z","end":"2026-08-04T22:05:24.357368Z","steps":["trace[1520534671] 'process raft request' (duration: 113.002883ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:05:24.357922Z","caller":"traceutil/trace.go:171","msg":"trace[1909399533] transaction","detail":"{read_only:false; response_revision:14598; number_of_response:1; }","duration":"106.989446ms","start":"2026-08-04T22:05:24.250893Z","end":"2026-08-04T22:05:24.357882Z","steps":["trace[1909399533] 'process raft request' (duration: 106.379321ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:05:49.13582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.744146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0640e862-3eeb-42fd-9fac-244059585d00\" ","response":"range_response_count:1 size:3637"} {"level":"info","ts":"2026-08-04T22:05:49.13591Z","caller":"traceutil/trace.go:171","msg":"trace[179296761] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0640e862-3eeb-42fd-9fac-244059585d00; range_end:; response_count:1; response_revision:14912; }","duration":"293.872049ms","start":"2026-08-04T22:05:48.842013Z","end":"2026-08-04T22:05:49.135885Z","steps":["trace[179296761] 'range keys from in-memory index tree' (duration: 293.585822ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:05:50.530398Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12752} {"level":"info","ts":"2026-08-04T22:05:50.613018Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12752,"took":"80.929402ms","hash":4038803524,"current-db-size-bytes":58634240,"current-db-size":"59 MB","current-db-size-in-use-bytes":28983296,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-04T22:05:50.613144Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4038803524,"revision":12752,"compact-revision":10527} {"level":"info","ts":"2026-08-04T22:07:15.774867Z","caller":"traceutil/trace.go:171","msg":"trace[1980480998] transaction","detail":"{read_only:false; response_revision:15727; number_of_response:1; }","duration":"115.237017ms","start":"2026-08-04T22:07:15.659603Z","end":"2026-08-04T22:07:15.77484Z","steps":["trace[1980480998] 'process raft request' (duration: 106.031173ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:07:15.906939Z","caller":"traceutil/trace.go:171","msg":"trace[1009242807] transaction","detail":"{read_only:false; response_revision:15728; number_of_response:1; }","duration":"113.928375ms","start":"2026-08-04T22:07:15.792979Z","end":"2026-08-04T22:07:15.906908Z","steps":["trace[1009242807] 'process raft request' (duration: 112.945342ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:07:16.178156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.078789ms","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-08-04T22:07:16.17826Z","caller":"traceutil/trace.go:171","msg":"trace[1211350692] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:15730; }","duration":"169.242073ms","start":"2026-08-04T22:07:16.008993Z","end":"2026-08-04T22:07:16.178235Z","steps":["trace[1211350692] 'range keys from in-memory index tree' (duration: 168.908034ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:07:16.178653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.682633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:665"} {"level":"info","ts":"2026-08-04T22:07:16.178767Z","caller":"traceutil/trace.go:171","msg":"trace[2047188424] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15730; }","duration":"169.844416ms","start":"2026-08-04T22:07:16.008889Z","end":"2026-08-04T22:07:16.178734Z","steps":["trace[2047188424] 'range keys from in-memory index tree' (duration: 169.450037ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:07:16.22727Z","caller":"traceutil/trace.go:171","msg":"trace[359007571] transaction","detail":"{read_only:false; response_revision:15732; number_of_response:1; }","duration":"135.478291ms","start":"2026-08-04T22:07:16.091763Z","end":"2026-08-04T22:07:16.227241Z","steps":["trace[359007571] 'process raft request' (duration: 134.286852ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:10:50.536549Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14926} {"level":"info","ts":"2026-08-04T22:10:50.627198Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14926,"took":"87.313975ms","hash":2748697478,"current-db-size-bytes":58634240,"current-db-size":"59 MB","current-db-size-in-use-bytes":30752768,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-08-04T22:10:50.627274Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2748697478,"revision":14926,"compact-revision":12752} {"level":"info","ts":"2026-08-04T22:13:18.534266Z","caller":"traceutil/trace.go:171","msg":"trace[555158795] transaction","detail":"{read_only:false; response_revision:18383; number_of_response:1; }","duration":"106.44904ms","start":"2026-08-04T22:13:18.427802Z","end":"2026-08-04T22:13:18.534251Z","steps":["trace[555158795] 'process raft request' (duration: 106.106872ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:13:25.361144Z","caller":"traceutil/trace.go:171","msg":"trace[1230933178] transaction","detail":"{read_only:false; response_revision:18420; number_of_response:1; }","duration":"194.521492ms","start":"2026-08-04T22:13:25.166598Z","end":"2026-08-04T22:13:25.361119Z","steps":["trace[1230933178] 'process raft request' (duration: 194.109582ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:13:25.745064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.785709ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-04T22:13:25.745168Z","caller":"traceutil/trace.go:171","msg":"trace[1866641138] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:18421; }","duration":"159.906582ms","start":"2026-08-04T22:13:25.585247Z","end":"2026-08-04T22:13:25.745153Z","steps":["trace[1866641138] 'range keys from in-memory index tree' (duration: 159.769838ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:13:25.745424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.441146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-04T22:13:25.745538Z","caller":"traceutil/trace.go:171","msg":"trace[1669279356] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:18421; }","duration":"271.590269ms","start":"2026-08-04T22:13:25.473909Z","end":"2026-08-04T22:13:25.7455Z","steps":["trace[1669279356] 'count revisions from in-memory index tree' (duration: 271.348333ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:13:25.745691Z","caller":"traceutil/trace.go:171","msg":"trace[616090808] transaction","detail":"{read_only:false; response_revision:18422; number_of_response:1; }","duration":"265.377548ms","start":"2026-08-04T22:13:25.480282Z","end":"2026-08-04T22:13:25.74566Z","steps":["trace[616090808] 'process raft request' (duration: 259.808012ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:13:25.763143Z","caller":"traceutil/trace.go:171","msg":"trace[1895696194] transaction","detail":"{read_only:false; response_revision:18424; number_of_response:1; }","duration":"159.361718ms","start":"2026-08-04T22:13:25.603749Z","end":"2026-08-04T22:13:25.763111Z","steps":["trace[1895696194] 'process raft request' (duration: 159.315597ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:13:25.763231Z","caller":"traceutil/trace.go:171","msg":"trace[597740615] transaction","detail":"{read_only:false; response_revision:18423; number_of_response:1; }","duration":"205.902521ms","start":"2026-08-04T22:13:25.557288Z","end":"2026-08-04T22:13:25.76319Z","steps":["trace[597740615] 'process raft request' (duration: 205.632214ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:13:26.177054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.266216ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-04T22:13:26.177156Z","caller":"traceutil/trace.go:171","msg":"trace[1866850268] linearizableReadLoop","detail":"{readStateIndex:19054; appliedIndex:19053; }","duration":"308.870877ms","start":"2026-08-04T22:13:25.868268Z","end":"2026-08-04T22:13:26.177139Z","steps":["trace[1866850268] 'read index received' (duration: 59.052µs)","trace[1866850268] 'applied index is now lower than readState.Index' (duration: 308.810745ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:13:26.177329Z","caller":"traceutil/trace.go:171","msg":"trace[1964012166] transaction","detail":"{read_only:false; response_revision:18426; number_of_response:1; }","duration":"339.873881ms","start":"2026-08-04T22:13:25.837431Z","end":"2026-08-04T22:13:26.177305Z","steps":["trace[1964012166] 'compare' (duration: 329.808585ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:13:26.177475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:13:25.837418Z","time spent":"339.971543ms","remote":"127.0.0.1:49070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T22:13:26.177561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.289986ms","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-08-04T22:13:26.17764Z","caller":"traceutil/trace.go:171","msg":"trace[74165004] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18426; }","duration":"309.43165ms","start":"2026-08-04T22:13:25.868192Z","end":"2026-08-04T22:13:26.177624Z","steps":["trace[74165004] 'agreement among raft nodes before linearized reading' (duration: 309.191784ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:13:26.177676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:13:25.868166Z","time spent":"309.501422ms","remote":"127.0.0.1:49070","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-08-04T22:13:26.177871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.232011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-6phcv\" ","response":"range_response_count:1 size:22133"} {"level":"warn","ts":"2026-08-04T22:13:26.17787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.891857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-04T22:13:26.177924Z","caller":"traceutil/trace.go:171","msg":"trace[1618500229] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-6phcv; range_end:; response_count:1; response_revision:18426; }","duration":"202.329873ms","start":"2026-08-04T22:13:25.975581Z","end":"2026-08-04T22:13:26.17791Z","steps":["trace[1618500229] 'agreement among raft nodes before linearized reading' (duration: 201.820041ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:13:26.177958Z","caller":"traceutil/trace.go:171","msg":"trace[513678294] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:18426; }","duration":"122.03645ms","start":"2026-08-04T22:13:26.055899Z","end":"2026-08-04T22:13:26.177935Z","steps":["trace[513678294] 'agreement among raft nodes before linearized reading' (duration: 121.747993ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:13:26.336099Z","caller":"traceutil/trace.go:171","msg":"trace[1257054824] transaction","detail":"{read_only:false; response_revision:18427; number_of_response:1; }","duration":"153.745651ms","start":"2026-08-04T22:13:26.18232Z","end":"2026-08-04T22:13:26.336065Z","steps":["trace[1257054824] 'process raft request' (duration: 115.704206ms)","trace[1257054824] 'compare' (duration: 37.802619ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:13:26.336221Z","caller":"traceutil/trace.go:171","msg":"trace[300357697] linearizableReadLoop","detail":"{readStateIndex:19056; appliedIndex:19054; }","duration":"149.509298ms","start":"2026-08-04T22:13:26.18669Z","end":"2026-08-04T22:13:26.3362Z","steps":["trace[300357697] 'read index received' (duration: 111.34363ms)","trace[300357697] 'applied index is now lower than readState.Index' (duration: 38.164098ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:13:26.336343Z","caller":"traceutil/trace.go:171","msg":"trace[1552963226] transaction","detail":"{read_only:false; response_revision:18428; number_of_response:1; }","duration":"153.809693ms","start":"2026-08-04T22:13:26.182517Z","end":"2026-08-04T22:13:26.336327Z","steps":["trace[1552963226] 'process raft request' (duration: 153.487765ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:13:26.337697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.982374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:95 size:954036"} {"level":"info","ts":"2026-08-04T22:13:26.337773Z","caller":"traceutil/trace.go:171","msg":"trace[333191654] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:95; response_revision:18428; }","duration":"151.094506ms","start":"2026-08-04T22:13:26.186661Z","end":"2026-08-04T22:13:26.337756Z","steps":["trace[333191654] 'agreement among raft nodes before linearized reading' (duration: 149.822745ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:14:56.856144Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"39582465ceaa2f67","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-04T22:14:56.860382Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-08-04T22:14:56.860475Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-08-04T22:15:50.543653Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17392} {"level":"info","ts":"2026-08-04T22:15:50.645814Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17392,"took":"96.241142ms","hash":700691802,"current-db-size-bytes":58634240,"current-db-size":"59 MB","current-db-size-in-use-bytes":34254848,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-08-04T22:15:50.645901Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":700691802,"revision":17392,"compact-revision":14926} {"level":"info","ts":"2026-08-04T22:19:18.628279Z","caller":"traceutil/trace.go:171","msg":"trace[772870122] transaction","detail":"{read_only:false; response_revision:21136; number_of_response:1; }","duration":"364.56449ms","start":"2026-08-04T22:19:18.263669Z","end":"2026-08-04T22:19:18.628234Z","steps":["trace[772870122] 'process raft request' (duration: 364.301494ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:19:18.628596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:19:18.26366Z","time spent":"364.811776ms","remote":"127.0.0.1:49070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T22:19:18.757291Z","caller":"traceutil/trace.go:171","msg":"trace[612827547] linearizableReadLoop","detail":"{readStateIndex:21855; appliedIndex:21853; }","duration":"376.186358ms","start":"2026-08-04T22:19:18.38108Z","end":"2026-08-04T22:19:18.757267Z","steps":["trace[612827547] 'read index received' (duration: 246.774283ms)","trace[612827547] 'applied index is now lower than readState.Index' (duration: 129.411035ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:19:18.757395Z","caller":"traceutil/trace.go:171","msg":"trace[1334298902] transaction","detail":"{read_only:false; response_revision:21137; number_of_response:1; }","duration":"421.948532ms","start":"2026-08-04T22:19:18.335433Z","end":"2026-08-04T22:19:18.757382Z","steps":["trace[1334298902] 'process raft request' (duration: 415.292344ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:19:18.757534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:19:18.335409Z","time spent":"422.042535ms","remote":"127.0.0.1:49070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T22:19:18.757634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.509955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-08-04T22:19:18.757742Z","caller":"traceutil/trace.go:171","msg":"trace[277259227] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:21137; }","duration":"376.690889ms","start":"2026-08-04T22:19:18.381028Z","end":"2026-08-04T22:19:18.757719Z","steps":["trace[277259227] 'agreement among raft nodes before linearized reading' (duration: 376.353141ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:19:18.757792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:19:18.381007Z","time spent":"376.776912ms","remote":"127.0.0.1:49070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-04T22:19:18.762243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.882164ms","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-08-04T22:19:18.762296Z","caller":"traceutil/trace.go:171","msg":"trace[536994072] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21138; }","duration":"363.981347ms","start":"2026-08-04T22:19:18.3983Z","end":"2026-08-04T22:19:18.762282Z","steps":["trace[536994072] 'agreement among raft nodes before linearized reading' (duration: 363.789883ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:19:18.762329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:19:18.398283Z","time spent":"364.039778ms","remote":"127.0.0.1:49070","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":"info","ts":"2026-08-04T22:19:18.992511Z","caller":"traceutil/trace.go:171","msg":"trace[425492083] linearizableReadLoop","detail":"{readStateIndex:21858; appliedIndex:21856; }","duration":"183.810907ms","start":"2026-08-04T22:19:18.808642Z","end":"2026-08-04T22:19:18.992453Z","steps":["trace[425492083] 'read index received' (duration: 17.428738ms)","trace[425492083] 'applied index is now lower than readState.Index' (duration: 166.380299ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:19:18.992556Z","caller":"traceutil/trace.go:171","msg":"trace[774695701] transaction","detail":"{read_only:false; response_revision:21140; number_of_response:1; }","duration":"226.438026ms","start":"2026-08-04T22:19:18.766048Z","end":"2026-08-04T22:19:18.992486Z","steps":["trace[774695701] 'process raft request' (duration: 212.81755ms)","trace[774695701] 'compare' (duration: 13.34673ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T22:19:18.992765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.081693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2083"} {"level":"info","ts":"2026-08-04T22:19:18.992863Z","caller":"traceutil/trace.go:171","msg":"trace[433035022] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:21140; }","duration":"184.272818ms","start":"2026-08-04T22:19:18.80856Z","end":"2026-08-04T22:19:18.992833Z","steps":["trace[433035022] 'agreement among raft nodes before linearized reading' (duration: 184.004272ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:19:19.242404Z","caller":"traceutil/trace.go:171","msg":"trace[1340256029] transaction","detail":"{read_only:false; response_revision:21141; number_of_response:1; }","duration":"142.515819ms","start":"2026-08-04T22:19:19.099855Z","end":"2026-08-04T22:19:19.242371Z","steps":["trace[1340256029] 'process raft request' (duration: 142.282034ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:19:19.272858Z","caller":"traceutil/trace.go:171","msg":"trace[1206670743] transaction","detail":"{read_only:false; response_revision:21142; number_of_response:1; }","duration":"170.224842ms","start":"2026-08-04T22:19:19.102596Z","end":"2026-08-04T22:19:19.27282Z","steps":["trace[1206670743] 'process raft request' (duration: 169.980346ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:19:19.430442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.695962ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-08-04T22:19:19.431057Z","caller":"traceutil/trace.go:171","msg":"trace[369544679] linearizableReadLoop","detail":"{readStateIndex:21861; appliedIndex:21860; }","duration":"152.400495ms","start":"2026-08-04T22:19:19.278634Z","end":"2026-08-04T22:19:19.431035Z","steps":["trace[369544679] 'read index received' (duration: 54.301µs)","trace[369544679] 'applied index is now lower than readState.Index' (duration: 152.344294ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T22:19:19.431202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.56288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-04T22:19:19.431237Z","caller":"traceutil/trace.go:171","msg":"trace[1329005888] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21142; }","duration":"152.656462ms","start":"2026-08-04T22:19:19.278568Z","end":"2026-08-04T22:19:19.431225Z","steps":["trace[1329005888] 'agreement among raft nodes before linearized reading' (duration: 152.56871ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:20:50.550794Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19708} {"level":"info","ts":"2026-08-04T22:20:50.665429Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19708,"took":"111.25388ms","hash":4248973726,"current-db-size-bytes":58634240,"current-db-size":"59 MB","current-db-size-in-use-bytes":29597696,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-04T22:20:50.665526Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4248973726,"revision":19708,"compact-revision":17392} {"level":"info","ts":"2026-08-04T22:23:12.268008Z","caller":"traceutil/trace.go:171","msg":"trace[1363682470] linearizableReadLoop","detail":"{readStateIndex:24220; appliedIndex:24219; }","duration":"133.3718ms","start":"2026-08-04T22:23:12.134614Z","end":"2026-08-04T22:23:12.267986Z","steps":["trace[1363682470] 'read index received' (duration: 101.349824ms)","trace[1363682470] 'applied index is now lower than readState.Index' (duration: 32.020996ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:23:12.268103Z","caller":"traceutil/trace.go:171","msg":"trace[1108178468] transaction","detail":"{read_only:false; response_revision:23426; number_of_response:1; }","duration":"137.309934ms","start":"2026-08-04T22:23:12.130753Z","end":"2026-08-04T22:23:12.268063Z","steps":["trace[1108178468] 'process raft request' (duration: 105.093913ms)","trace[1108178468] 'compare' (duration: 32.019716ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T22:23:12.268237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.617617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1286"} {"level":"info","ts":"2026-08-04T22:23:12.268267Z","caller":"traceutil/trace.go:171","msg":"trace[1649224563] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:23426; }","duration":"133.687618ms","start":"2026-08-04T22:23:12.13457Z","end":"2026-08-04T22:23:12.268258Z","steps":["trace[1649224563] 'agreement among raft nodes before linearized reading' (duration: 133.526914ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:23:12.274204Z","caller":"traceutil/trace.go:171","msg":"trace[1693924118] transaction","detail":"{read_only:false; response_revision:23427; number_of_response:1; }","duration":"137.779675ms","start":"2026-08-04T22:23:12.136377Z","end":"2026-08-04T22:23:12.274157Z","steps":["trace[1693924118] 'process raft request' (duration: 137.55785ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:23:12.274347Z","caller":"traceutil/trace.go:171","msg":"trace[460214133] transaction","detail":"{read_only:false; response_revision:23428; number_of_response:1; }","duration":"137.692293ms","start":"2026-08-04T22:23:12.136622Z","end":"2026-08-04T22:23:12.274314Z","steps":["trace[460214133] 'process raft request' (duration: 137.453818ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:23:12.274616Z","caller":"traceutil/trace.go:171","msg":"trace[695511916] transaction","detail":"{read_only:false; response_revision:23429; number_of_response:1; }","duration":"134.848466ms","start":"2026-08-04T22:23:12.139745Z","end":"2026-08-04T22:23:12.274593Z","steps":["trace[695511916] 'process raft request' (duration: 134.388745ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:23:12.274687Z","caller":"traceutil/trace.go:171","msg":"trace[221443831] transaction","detail":"{read_only:false; response_revision:23430; number_of_response:1; }","duration":"134.865695ms","start":"2026-08-04T22:23:12.139797Z","end":"2026-08-04T22:23:12.274663Z","steps":["trace[221443831] 'process raft request' (duration: 134.683191ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:23:12.275156Z","caller":"traceutil/trace.go:171","msg":"trace[1138161247] transaction","detail":"{read_only:false; response_revision:23431; number_of_response:1; }","duration":"103.427974ms","start":"2026-08-04T22:23:12.171716Z","end":"2026-08-04T22:23:12.275144Z","steps":["trace[1138161247] 'process raft request' (duration: 102.902031ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:23:12.275498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.719996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/kubeadmcontrolplanetemplates.controlplane.cluster.x-k8s.io\" ","response":"range_response_count:1 size:170398"} {"level":"info","ts":"2026-08-04T22:23:12.275608Z","caller":"traceutil/trace.go:171","msg":"trace[1922492266] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/kubeadmcontrolplanetemplates.controlplane.cluster.x-k8s.io; range_end:; response_count:1; response_revision:23432; }","duration":"140.86593ms","start":"2026-08-04T22:23:12.134708Z","end":"2026-08-04T22:23:12.275574Z","steps":["trace[1922492266] 'agreement among raft nodes before linearized reading' (duration: 140.51028ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:23:12.275694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.212453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3685"} {"level":"info","ts":"2026-08-04T22:23:12.275728Z","caller":"traceutil/trace.go:171","msg":"trace[1826312665] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:23432; }","duration":"132.295125ms","start":"2026-08-04T22:23:12.143421Z","end":"2026-08-04T22:23:12.275716Z","steps":["trace[1826312665] 'agreement among raft nodes before linearized reading' (duration: 132.194143ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:23:20.161095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.209009ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-04T22:23:20.161196Z","caller":"traceutil/trace.go:171","msg":"trace[1157997771] linearizableReadLoop","detail":"{readStateIndex:24449; appliedIndex:24448; }","duration":"162.52113ms","start":"2026-08-04T22:23:19.99866Z","end":"2026-08-04T22:23:20.161181Z","steps":["trace[1157997771] 'read index received' (duration: 52.057495ms)","trace[1157997771] 'applied index is now lower than readState.Index' (duration: 110.462575ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T22:23:20.161361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.698484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-08-04T22:23:20.161395Z","caller":"traceutil/trace.go:171","msg":"trace[1379711923] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:23653; }","duration":"162.754936ms","start":"2026-08-04T22:23:19.998631Z","end":"2026-08-04T22:23:20.161386Z","steps":["trace[1379711923] 'agreement among raft nodes before linearized reading' (duration: 162.594182ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:23:20.161588Z","caller":"traceutil/trace.go:171","msg":"trace[1987205854] transaction","detail":"{read_only:false; response_revision:23653; number_of_response:1; }","duration":"184.75178ms","start":"2026-08-04T22:23:19.976825Z","end":"2026-08-04T22:23:20.161577Z","steps":["trace[1987205854] 'process raft request' (duration: 73.985938ms)","trace[1987205854] 'compare' (duration: 109.927071ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:23:20.407358Z","caller":"traceutil/trace.go:171","msg":"trace[792775789] transaction","detail":"{read_only:false; response_revision:23654; number_of_response:1; }","duration":"241.392776ms","start":"2026-08-04T22:23:20.16592Z","end":"2026-08-04T22:23:20.407313Z","steps":["trace[792775789] 'process raft request' (duration: 205.255818ms)","trace[792775789] 'compare' (duration: 35.911203ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:23:20.423296Z","caller":"traceutil/trace.go:171","msg":"trace[158836029] linearizableReadLoop","detail":"{readStateIndex:24452; appliedIndex:24449; }","duration":"100.560164ms","start":"2026-08-04T22:23:20.32244Z","end":"2026-08-04T22:23:20.423Z","steps":["trace[158836029] 'read index received' (duration: 48.723594ms)","trace[158836029] 'applied index is now lower than readState.Index' (duration: 51.83533ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T22:23:20.423734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.270701ms","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-08-04T22:23:20.423912Z","caller":"traceutil/trace.go:171","msg":"trace[586008888] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:23656; }","duration":"101.408394ms","start":"2026-08-04T22:23:20.322382Z","end":"2026-08-04T22:23:20.423791Z","steps":["trace[586008888] 'agreement among raft nodes before linearized reading' (duration: 101.007124ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:23:20.424614Z","caller":"traceutil/trace.go:171","msg":"trace[765965927] transaction","detail":"{read_only:false; response_revision:23655; number_of_response:1; }","duration":"116.04135ms","start":"2026-08-04T22:23:20.308556Z","end":"2026-08-04T22:23:20.424598Z","steps":["trace[765965927] 'process raft request' (duration: 113.9416ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:23:20.424812Z","caller":"traceutil/trace.go:171","msg":"trace[859909778] transaction","detail":"{read_only:false; response_revision:23656; number_of_response:1; }","duration":"116.212725ms","start":"2026-08-04T22:23:20.308588Z","end":"2026-08-04T22:23:20.424801Z","steps":["trace[859909778] 'process raft request' (duration: 114.166845ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:25:50.556346Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21967} {"level":"info","ts":"2026-08-04T22:25:50.657346Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21967,"took":"97.748367ms","hash":2573090807,"current-db-size-bytes":59850752,"current-db-size":"60 MB","current-db-size-in-use-bytes":45248512,"current-db-size-in-use":"45 MB"} {"level":"info","ts":"2026-08-04T22:25:50.657413Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2573090807,"revision":21967,"compact-revision":19708} {"level":"info","ts":"2026-08-04T22:26:53.148349Z","caller":"traceutil/trace.go:171","msg":"trace[1686471515] transaction","detail":"{read_only:false; response_revision:25788; number_of_response:1; }","duration":"175.788117ms","start":"2026-08-04T22:26:52.972527Z","end":"2026-08-04T22:26:53.148315Z","steps":["trace[1686471515] 'process raft request' (duration: 151.049258ms)","trace[1686471515] 'compare' (duration: 24.602976ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:26:53.149748Z","caller":"traceutil/trace.go:171","msg":"trace[1857796600] linearizableReadLoop","detail":"{readStateIndex:26638; appliedIndex:26636; }","duration":"172.177929ms","start":"2026-08-04T22:26:52.977546Z","end":"2026-08-04T22:26:53.149724Z","steps":["trace[1857796600] 'read index received' (duration: 146.006775ms)","trace[1857796600] 'applied index is now lower than readState.Index' (duration: 26.170044ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T22:26:53.149996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.426435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/disruption-controller\" ","response":"range_response_count:1 size:208"} {"level":"info","ts":"2026-08-04T22:26:53.150036Z","caller":"traceutil/trace.go:171","msg":"trace[18816634] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/disruption-controller; range_end:; response_count:1; response_revision:25791; }","duration":"172.500957ms","start":"2026-08-04T22:26:52.977524Z","end":"2026-08-04T22:26:53.150025Z","steps":["trace[18816634] 'agreement among raft nodes before linearized reading' (duration: 172.319463ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:26:53.150397Z","caller":"traceutil/trace.go:171","msg":"trace[925812978] transaction","detail":"{read_only:false; response_revision:25789; number_of_response:1; }","duration":"175.745536ms","start":"2026-08-04T22:26:52.974636Z","end":"2026-08-04T22:26:53.150381Z","steps":["trace[925812978] 'process raft request' (duration: 174.804453ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:26:53.15095Z","caller":"traceutil/trace.go:171","msg":"trace[27315234] transaction","detail":"{read_only:false; response_revision:25790; number_of_response:1; }","duration":"166.695897ms","start":"2026-08-04T22:26:52.984227Z","end":"2026-08-04T22:26:53.150923Z","steps":["trace[27315234] 'process raft request' (duration: 165.396785ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:26:54.010778Z","caller":"traceutil/trace.go:171","msg":"trace[1343462164] linearizableReadLoop","detail":"{readStateIndex:26652; appliedIndex:26651; }","duration":"132.813207ms","start":"2026-08-04T22:26:53.877945Z","end":"2026-08-04T22:26:54.010758Z","steps":["trace[1343462164] 'read index received' (duration: 132.564151ms)","trace[1343462164] 'applied index is now lower than readState.Index' (duration: 248.276µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:26:54.010819Z","caller":"traceutil/trace.go:171","msg":"trace[1846637711] transaction","detail":"{read_only:false; response_revision:25803; number_of_response:1; }","duration":"169.311991ms","start":"2026-08-04T22:26:53.841486Z","end":"2026-08-04T22:26:54.010798Z","steps":["trace[1846637711] 'process raft request' (duration: 168.934082ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:26:54.011117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.162645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/container-infra-registry.18c8ba95a88473bd\" ","response":"range_response_count:1 size:722"} {"level":"info","ts":"2026-08-04T22:26:54.011168Z","caller":"traceutil/trace.go:171","msg":"trace[1402263611] range","detail":"{range_begin:/registry/events/openstack/container-infra-registry.18c8ba95a88473bd; range_end:; response_count:1; response_revision:25803; }","duration":"133.262887ms","start":"2026-08-04T22:26:53.877891Z","end":"2026-08-04T22:26:54.011154Z","steps":["trace[1402263611] 'agreement among raft nodes before linearized reading' (duration: 132.992931ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:26:54.386493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.597442ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-04T22:26:54.386712Z","caller":"traceutil/trace.go:171","msg":"trace[1326726676] linearizableReadLoop","detail":"{readStateIndex:26654; appliedIndex:26652; }","duration":"348.213052ms","start":"2026-08-04T22:26:54.038481Z","end":"2026-08-04T22:26:54.386695Z","steps":["trace[1326726676] 'read index received' (duration: 115.261851ms)","trace[1326726676] 'applied index is now lower than readState.Index' (duration: 232.949951ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:26:54.386807Z","caller":"traceutil/trace.go:171","msg":"trace[711292275] transaction","detail":"{read_only:false; response_revision:25805; number_of_response:1; }","duration":"357.034325ms","start":"2026-08-04T22:26:54.029764Z","end":"2026-08-04T22:26:54.386798Z","steps":["trace[711292275] 'process raft request' (duration: 356.844631ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:26:54.38686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:26:54.02972Z","time spent":"357.112948ms","remote":"127.0.0.1:49070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T22:26:54.386904Z","caller":"traceutil/trace.go:171","msg":"trace[301375647] transaction","detail":"{read_only:false; response_revision:25804; number_of_response:1; }","duration":"358.776728ms","start":"2026-08-04T22:26:54.028109Z","end":"2026-08-04T22:26:54.386885Z","steps":["trace[301375647] 'process raft request' (duration: 125.681694ms)","trace[301375647] 'compare' (duration: 232.191533ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T22:26:54.387012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:26:54.028087Z","time spent":"358.87533ms","remote":"127.0.0.1:48908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T22:26:54.387066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.59282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.248\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-08-04T22:26:54.387093Z","caller":"traceutil/trace.go:171","msg":"trace[1522223656] range","detail":"{range_begin:/registry/masterleases/199.204.45.248; range_end:; response_count:1; response_revision:25805; }","duration":"348.661542ms","start":"2026-08-04T22:26:54.038424Z","end":"2026-08-04T22:26:54.387086Z","steps":["trace[1522223656] 'agreement among raft nodes before linearized reading' (duration: 348.545509ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:26:54.387118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:26:54.038403Z","time spent":"348.709954ms","remote":"127.0.0.1:48882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":163,"request content":"key:\"/registry/masterleases/199.204.45.248\" "} {"level":"warn","ts":"2026-08-04T22:26:54.387255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.803478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-04T22:26:54.387286Z","caller":"traceutil/trace.go:171","msg":"trace[1239449101] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25805; }","duration":"111.861539ms","start":"2026-08-04T22:26:54.275418Z","end":"2026-08-04T22:26:54.387279Z","steps":["trace[1239449101] 'agreement among raft nodes before linearized reading' (duration: 111.815417ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:26:54.599772Z","caller":"traceutil/trace.go:171","msg":"trace[1791654088] transaction","detail":"{read_only:false; response_revision:25806; number_of_response:1; }","duration":"181.600417ms","start":"2026-08-04T22:26:54.418132Z","end":"2026-08-04T22:26:54.599733Z","steps":["trace[1791654088] 'process raft request' (duration: 158.481268ms)","trace[1791654088] 'compare' (duration: 22.485084ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:26:54.60155Z","caller":"traceutil/trace.go:171","msg":"trace[1025077518] transaction","detail":"{read_only:false; response_revision:25807; number_of_response:1; }","duration":"180.86101ms","start":"2026-08-04T22:26:54.420651Z","end":"2026-08-04T22:26:54.601512Z","steps":["trace[1025077518] 'process raft request' (duration: 180.262335ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:26:58.609532Z","caller":"traceutil/trace.go:171","msg":"trace[801686155] transaction","detail":"{read_only:false; response_revision:25837; number_of_response:1; }","duration":"129.448225ms","start":"2026-08-04T22:26:58.480065Z","end":"2026-08-04T22:26:58.609513Z","steps":["trace[801686155] 'process raft request' (duration: 129.315341ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:26:58.731606Z","caller":"traceutil/trace.go:171","msg":"trace[1419056519] transaction","detail":"{read_only:false; response_revision:25838; number_of_response:1; }","duration":"120.911368ms","start":"2026-08-04T22:26:58.610666Z","end":"2026-08-04T22:26:58.731577Z","steps":["trace[1419056519] 'process raft request' (duration: 113.59397ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:26:58.791168Z","caller":"traceutil/trace.go:171","msg":"trace[1652830693] linearizableReadLoop","detail":"{readStateIndex:26690; appliedIndex:26687; }","duration":"108.557709ms","start":"2026-08-04T22:26:58.682592Z","end":"2026-08-04T22:26:58.79115Z","steps":["trace[1652830693] 'read index received' (duration: 41.68179ms)","trace[1652830693] 'applied index is now lower than readState.Index' (duration: 66.875289ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:26:58.791255Z","caller":"traceutil/trace.go:171","msg":"trace[1856454630] transaction","detail":"{read_only:false; response_revision:25840; number_of_response:1; }","duration":"176.77709ms","start":"2026-08-04T22:26:58.614473Z","end":"2026-08-04T22:26:58.79125Z","steps":["trace[1856454630] 'process raft request' (duration: 176.647407ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:26:58.79127Z","caller":"traceutil/trace.go:171","msg":"trace[391141000] transaction","detail":"{read_only:false; response_revision:25839; number_of_response:1; }","duration":"178.168293ms","start":"2026-08-04T22:26:58.61308Z","end":"2026-08-04T22:26:58.791249Z","steps":["trace[391141000] 'process raft request' (duration: 177.868166ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:26:58.791419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.812655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-04T22:26:58.791441Z","caller":"traceutil/trace.go:171","msg":"trace[156431363] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:25840; }","duration":"108.880497ms","start":"2026-08-04T22:26:58.682554Z","end":"2026-08-04T22:26:58.791435Z","steps":["trace[156431363] 'agreement among raft nodes before linearized reading' (duration: 108.815435ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:26:58.949224Z","caller":"traceutil/trace.go:171","msg":"trace[439344440] transaction","detail":"{read_only:false; response_revision:25841; number_of_response:1; }","duration":"153.396255ms","start":"2026-08-04T22:26:58.795791Z","end":"2026-08-04T22:26:58.949188Z","steps":["trace[439344440] 'process raft request' (duration: 100.78377ms)","trace[439344440] 'compare' (duration: 52.370738ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T22:26:59.197093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.054176ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-04T22:26:59.197279Z","caller":"traceutil/trace.go:171","msg":"trace[2108924650] transaction","detail":"{read_only:false; response_revision:25842; number_of_response:1; }","duration":"209.179746ms","start":"2026-08-04T22:26:58.988079Z","end":"2026-08-04T22:26:59.197258Z","steps":["trace[2108924650] 'process raft request' (duration: 86.884754ms)","trace[2108924650] 'compare' (duration: 121.846441ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:26:59.519281Z","caller":"traceutil/trace.go:171","msg":"trace[1887257144] linearizableReadLoop","detail":"{readStateIndex:26695; appliedIndex:26694; }","duration":"240.301979ms","start":"2026-08-04T22:26:59.278955Z","end":"2026-08-04T22:26:59.519257Z","steps":["trace[1887257144] 'read index received' (duration: 240.171696ms)","trace[1887257144] 'applied index is now lower than readState.Index' (duration: 129.103µs)"],"step_count":2} {"level":"warn","ts":"2026-08-04T22:26:59.519436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.459593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-04T22:26:59.519476Z","caller":"traceutil/trace.go:171","msg":"trace[1253096189] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25845; }","duration":"240.545005ms","start":"2026-08-04T22:26:59.27892Z","end":"2026-08-04T22:26:59.519465Z","steps":["trace[1253096189] 'agreement among raft nodes before linearized reading' (duration: 240.435293ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:26:59.519645Z","caller":"traceutil/trace.go:171","msg":"trace[2089056299] transaction","detail":"{read_only:false; response_revision:25845; number_of_response:1; }","duration":"243.911396ms","start":"2026-08-04T22:26:59.275708Z","end":"2026-08-04T22:26:59.51962Z","steps":["trace[2089056299] 'process raft request' (duration: 243.370403ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:26:59.918709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.002857ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-08-04T22:26:59.919121Z","caller":"traceutil/trace.go:171","msg":"trace[935959166] linearizableReadLoop","detail":"{readStateIndex:26700; appliedIndex:26695; }","duration":"398.594782ms","start":"2026-08-04T22:26:59.520508Z","end":"2026-08-04T22:26:59.919103Z","steps":["trace[935959166] 'read index received' (duration: 100.083603ms)","trace[935959166] 'applied index is now lower than readState.Index' (duration: 298.509579ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:26:59.919447Z","caller":"traceutil/trace.go:171","msg":"trace[1360706686] transaction","detail":"{read_only:false; response_revision:25846; number_of_response:1; }","duration":"633.321866ms","start":"2026-08-04T22:26:59.286108Z","end":"2026-08-04T22:26:59.91943Z","steps":["trace[1360706686] 'process raft request' (duration: 632.688011ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:26:59.919578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:26:59.286093Z","time spent":"633.411037ms","remote":"127.0.0.1:49070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T22:26:59.919793Z","caller":"traceutil/trace.go:171","msg":"trace[511638846] transaction","detail":"{read_only:false; response_revision:25847; number_of_response:1; }","duration":"630.952908ms","start":"2026-08-04T22:26:59.288823Z","end":"2026-08-04T22:26:59.919776Z","steps":["trace[511638846] 'process raft request' (duration: 630.098368ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:26:59.919862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:26:59.288811Z","time spent":"631.01522ms","remote":"127.0.0.1:49070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T22:26:59.919995Z","caller":"traceutil/trace.go:171","msg":"trace[443157458] transaction","detail":"{read_only:false; response_revision:25848; number_of_response:1; }","duration":"607.977242ms","start":"2026-08-04T22:26:59.312008Z","end":"2026-08-04T22:26:59.919985Z","steps":["trace[443157458] 'process raft request' (duration: 606.968698ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:26:59.920081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:26:59.311986Z","time spent":"608.047284ms","remote":"127.0.0.1:49070","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-08-04T22:26:59.920288Z","caller":"traceutil/trace.go:171","msg":"trace[1544803821] transaction","detail":"{read_only:false; response_revision:25849; number_of_response:1; }","duration":"552.266893ms","start":"2026-08-04T22:26:59.368004Z","end":"2026-08-04T22:26:59.920271Z","steps":["trace[1544803821] 'process raft request' (duration: 551.028913ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:26:59.920369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:26:59.367983Z","time spent":"552.347165ms","remote":"127.0.0.1:49070","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-08-04T22:26:59.920554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.041036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-04T22:26:59.920617Z","caller":"traceutil/trace.go:171","msg":"trace[312610794] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25849; }","duration":"400.135969ms","start":"2026-08-04T22:26:59.520465Z","end":"2026-08-04T22:26:59.9206Z","steps":["trace[312610794] 'agreement among raft nodes before linearized reading' (duration: 400.055927ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:26:59.920666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:26:59.520446Z","time spent":"400.208961ms","remote":"127.0.0.1:48854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-04T22:26:59.920977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.954551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-08-04T22:26:59.921029Z","caller":"traceutil/trace.go:171","msg":"trace[1469591802] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25849; }","duration":"302.050204ms","start":"2026-08-04T22:26:59.618968Z","end":"2026-08-04T22:26:59.921018Z","steps":["trace[1469591802] 'agreement among raft nodes before linearized reading' (duration: 301.89982ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:26:59.921075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:26:59.61895Z","time spent":"302.113056ms","remote":"127.0.0.1:49070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-04T22:26:59.921528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.961453ms","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-08-04T22:26:59.921584Z","caller":"traceutil/trace.go:171","msg":"trace[213273900] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25849; }","duration":"295.043885ms","start":"2026-08-04T22:26:59.62652Z","end":"2026-08-04T22:26:59.921564Z","steps":["trace[213273900] 'agreement among raft nodes before linearized reading' (duration: 294.921392ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:00.246391Z","caller":"traceutil/trace.go:171","msg":"trace[44939865] transaction","detail":"{read_only:false; response_revision:25850; number_of_response:1; }","duration":"311.359121ms","start":"2026-08-04T22:26:59.935002Z","end":"2026-08-04T22:27:00.246362Z","steps":["trace[44939865] 'process raft request' (duration: 211.619315ms)","trace[44939865] 'compare' (duration: 98.838423ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T22:27:00.246631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:26:59.934981Z","time spent":"311.553105ms","remote":"127.0.0.1:49070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T22:27:00.253856Z","caller":"traceutil/trace.go:171","msg":"trace[2111051354] linearizableReadLoop","detail":"{readStateIndex:26702; appliedIndex:26700; }","duration":"314.208458ms","start":"2026-08-04T22:26:59.939625Z","end":"2026-08-04T22:27:00.253834Z","steps":["trace[2111051354] 'read index received' (duration: 206.92779ms)","trace[2111051354] 'applied index is now lower than readState.Index' (duration: 107.279418ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:27:00.253962Z","caller":"traceutil/trace.go:171","msg":"trace[1290363988] transaction","detail":"{read_only:false; response_revision:25851; number_of_response:1; }","duration":"318.892732ms","start":"2026-08-04T22:26:59.935058Z","end":"2026-08-04T22:27:00.253951Z","steps":["trace[1290363988] 'process raft request' (duration: 318.644166ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:00.254074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:26:59.93503Z","time spent":"318.959934ms","remote":"127.0.0.1:49070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T22:27:00.254064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.343877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/services/\" range_end:\"/registry/openstack.k-orc.cloud/services0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-04T22:27:00.254143Z","caller":"traceutil/trace.go:171","msg":"trace[1452997464] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/services/; range_end:/registry/openstack.k-orc.cloud/services0; response_count:0; response_revision:25851; }","duration":"168.47396ms","start":"2026-08-04T22:27:00.085649Z","end":"2026-08-04T22:27:00.254122Z","steps":["trace[1452997464] 'agreement among raft nodes before linearized reading' (duration: 168.342267ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:00.254403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.770941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" ","response":"range_response_count:32 size:274825"} {"level":"info","ts":"2026-08-04T22:27:00.254444Z","caller":"traceutil/trace.go:171","msg":"trace[657498743] range","detail":"{range_begin:/registry/deployments/openstack/; range_end:/registry/deployments/openstack0; response_count:32; response_revision:25851; }","duration":"314.839414ms","start":"2026-08-04T22:26:59.939596Z","end":"2026-08-04T22:27:00.254435Z","steps":["trace[657498743] 'agreement among raft nodes before linearized reading' (duration: 314.414393ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:00.254505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:26:59.939587Z","time spent":"314.911546ms","remote":"127.0.0.1:49256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":32,"response size":274848,"request content":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" "} {"level":"warn","ts":"2026-08-04T22:27:00.539541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.123087ms","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-08-04T22:27:00.539641Z","caller":"traceutil/trace.go:171","msg":"trace[1316355175] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:25851; }","duration":"179.263371ms","start":"2026-08-04T22:27:00.360354Z","end":"2026-08-04T22:27:00.539617Z","steps":["trace[1316355175] 'count revisions from in-memory index tree' (duration: 179.052446ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:00.540436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.68582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinesets/\" range_end:\"/registry/cluster.x-k8s.io/machinesets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-04T22:27:00.540567Z","caller":"traceutil/trace.go:171","msg":"trace[1145273387] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinesets/; range_end:/registry/cluster.x-k8s.io/machinesets0; response_count:0; response_revision:25851; }","duration":"143.820824ms","start":"2026-08-04T22:27:00.396698Z","end":"2026-08-04T22:27:00.540519Z","steps":["trace[1145273387] 'count revisions from in-memory index tree' (duration: 143.602298ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:01.005818Z","caller":"traceutil/trace.go:171","msg":"trace[1387399589] transaction","detail":"{read_only:false; response_revision:25853; number_of_response:1; }","duration":"207.915395ms","start":"2026-08-04T22:27:00.797877Z","end":"2026-08-04T22:27:01.005792Z","steps":["trace[1387399589] 'process raft request' (duration: 183.444503ms)","trace[1387399589] 'compare' (duration: 23.854607ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:27:01.015917Z","caller":"traceutil/trace.go:171","msg":"trace[1967119193] linearizableReadLoop","detail":"{readStateIndex:26705; appliedIndex:26703; }","duration":"134.360223ms","start":"2026-08-04T22:27:00.881531Z","end":"2026-08-04T22:27:01.015892Z","steps":["trace[1967119193] 'read index received' (duration: 99.876759ms)","trace[1967119193] 'applied index is now lower than readState.Index' (duration: 34.482564ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:27:01.016057Z","caller":"traceutil/trace.go:171","msg":"trace[1032323252] transaction","detail":"{read_only:false; response_revision:25854; number_of_response:1; }","duration":"217.459875ms","start":"2026-08-04T22:27:00.798586Z","end":"2026-08-04T22:27:01.016046Z","steps":["trace[1032323252] 'process raft request' (duration: 217.163588ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:01.016365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.826375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2083"} {"level":"info","ts":"2026-08-04T22:27:01.016451Z","caller":"traceutil/trace.go:171","msg":"trace[799826151] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:25854; }","duration":"134.972519ms","start":"2026-08-04T22:27:00.881456Z","end":"2026-08-04T22:27:01.016428Z","steps":["trace[799826151] 'agreement among raft nodes before linearized reading' (duration: 134.681121ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:01.354882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.556029ms","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-08-04T22:27:01.355025Z","caller":"traceutil/trace.go:171","msg":"trace[389763846] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25855; }","duration":"153.712812ms","start":"2026-08-04T22:27:01.201264Z","end":"2026-08-04T22:27:01.354977Z","steps":["trace[389763846] 'range keys from in-memory index tree' (duration: 153.346102ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:01.540894Z","caller":"traceutil/trace.go:171","msg":"trace[941052549] linearizableReadLoop","detail":"{readStateIndex:26707; appliedIndex:26706; }","duration":"283.410863ms","start":"2026-08-04T22:27:01.257466Z","end":"2026-08-04T22:27:01.540877Z","steps":["trace[941052549] 'read index received' (duration: 283.252089ms)","trace[941052549] 'applied index is now lower than readState.Index' (duration: 158.144µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:27:01.540961Z","caller":"traceutil/trace.go:171","msg":"trace[798523059] transaction","detail":"{read_only:false; response_revision:25856; number_of_response:1; }","duration":"327.146633ms","start":"2026-08-04T22:27:01.213777Z","end":"2026-08-04T22:27:01.540923Z","steps":["trace[798523059] 'process raft request' (duration: 326.962568ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:01.541071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.598487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-08-04T22:27:01.541091Z","caller":"traceutil/trace.go:171","msg":"trace[1412220171] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25856; }","duration":"283.668459ms","start":"2026-08-04T22:27:01.257417Z","end":"2026-08-04T22:27:01.541085Z","steps":["trace[1412220171] 'agreement among raft nodes before linearized reading' (duration: 283.552036ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:01.541108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:01.213752Z","time spent":"327.284685ms","remote":"127.0.0.1:49070","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-08-04T22:27:01.5621Z","caller":"traceutil/trace.go:171","msg":"trace[169605477] transaction","detail":"{read_only:false; response_revision:25857; number_of_response:1; }","duration":"197.476351ms","start":"2026-08-04T22:27:01.364593Z","end":"2026-08-04T22:27:01.562069Z","steps":["trace[169605477] 'process raft request' (duration: 195.183115ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:01.562488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.956263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-04T22:27:01.562578Z","caller":"traceutil/trace.go:171","msg":"trace[130097909] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:25858; }","duration":"165.107467ms","start":"2026-08-04T22:27:01.39745Z","end":"2026-08-04T22:27:01.562557Z","steps":["trace[130097909] 'agreement among raft nodes before linearized reading' (duration: 164.920862ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:01.562606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.648292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-04T22:27:01.562682Z","caller":"traceutil/trace.go:171","msg":"trace[1490366009] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25858; }","duration":"284.773455ms","start":"2026-08-04T22:27:01.27789Z","end":"2026-08-04T22:27:01.562664Z","steps":["trace[1490366009] 'agreement among raft nodes before linearized reading' (duration: 284.610341ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:01.964085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.375755ms","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":"info","ts":"2026-08-04T22:27:01.964159Z","caller":"traceutil/trace.go:171","msg":"trace[1236082563] 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:25858; }","duration":"196.482028ms","start":"2026-08-04T22:27:01.767658Z","end":"2026-08-04T22:27:01.96414Z","steps":["trace[1236082563] 'range keys from in-memory index tree' (duration: 196.319454ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:01.964425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.8143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-04T22:27:01.964505Z","caller":"traceutil/trace.go:171","msg":"trace[1133368056] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:25858; }","duration":"171.911322ms","start":"2026-08-04T22:27:01.792577Z","end":"2026-08-04T22:27:01.964488Z","steps":["trace[1133368056] 'count revisions from in-memory index tree' (duration: 171.726939ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:02.411522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.549032ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-04T22:27:02.411663Z","caller":"traceutil/trace.go:171","msg":"trace[2003907172] linearizableReadLoop","detail":"{readStateIndex:26713; appliedIndex:26710; }","duration":"442.25296ms","start":"2026-08-04T22:27:01.9694Z","end":"2026-08-04T22:27:02.411653Z","steps":["trace[2003907172] 'read index received' (duration: 37.913748ms)","trace[2003907172] 'applied index is now lower than readState.Index' (duration: 404.338422ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:27:02.411829Z","caller":"traceutil/trace.go:171","msg":"trace[1416436155] transaction","detail":"{read_only:false; response_revision:25860; number_of_response:1; }","duration":"480.906526ms","start":"2026-08-04T22:27:01.930912Z","end":"2026-08-04T22:27:02.411819Z","steps":["trace[1416436155] 'process raft request' (duration: 269.002794ms)","trace[1416436155] 'compare' (duration: 211.148452ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T22:27:02.41188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:01.930901Z","time spent":"480.953706ms","remote":"127.0.0.1:49070","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-08-04T22:27:02.412004Z","caller":"traceutil/trace.go:171","msg":"trace[226553429] transaction","detail":"{read_only:false; response_revision:25861; number_of_response:1; }","duration":"480.875115ms","start":"2026-08-04T22:27:01.931123Z","end":"2026-08-04T22:27:02.411998Z","steps":["trace[226553429] 'process raft request' (duration: 480.475365ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:02.412042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:01.931095Z","time spent":"480.925826ms","remote":"127.0.0.1:49070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T22:27:02.412125Z","caller":"traceutil/trace.go:171","msg":"trace[1206555304] transaction","detail":"{read_only:false; response_revision:25862; number_of_response:1; }","duration":"473.641779ms","start":"2026-08-04T22:27:01.938478Z","end":"2026-08-04T22:27:02.41212Z","steps":["trace[1206555304] 'process raft request' (duration: 473.153177ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:02.412159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:01.938441Z","time spent":"473.70032ms","remote":"127.0.0.1:49070","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-08-04T22:27:02.412243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.857994ms","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-08-04T22:27:02.412264Z","caller":"traceutil/trace.go:171","msg":"trace[1382513702] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:25862; }","duration":"442.933555ms","start":"2026-08-04T22:27:01.969324Z","end":"2026-08-04T22:27:02.412257Z","steps":["trace[1382513702] 'agreement among raft nodes before linearized reading' (duration: 442.899314ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:02.412279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:01.969279Z","time spent":"442.996147ms","remote":"127.0.0.1:49008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" "} {"level":"warn","ts":"2026-08-04T22:27:02.412412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.43731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-04T22:27:02.412438Z","caller":"traceutil/trace.go:171","msg":"trace[1858160874] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:25862; }","duration":"301.509811ms","start":"2026-08-04T22:27:02.110921Z","end":"2026-08-04T22:27:02.412431Z","steps":["trace[1858160874] 'agreement among raft nodes before linearized reading' (duration: 301.44032ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:02.412456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:02.110896Z","time spent":"301.554163ms","remote":"127.0.0.1:35860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":37,"response size":31,"request content":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true "} {"level":"warn","ts":"2026-08-04T22:27:02.412719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.155713ms","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-08-04T22:27:02.412743Z","caller":"traceutil/trace.go:171","msg":"trace[101124856] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25862; }","duration":"154.235835ms","start":"2026-08-04T22:27:02.258502Z","end":"2026-08-04T22:27:02.412737Z","steps":["trace[101124856] 'agreement among raft nodes before linearized reading' (duration: 154.153353ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:02.413047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.505715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-08-04T22:27:02.413066Z","caller":"traceutil/trace.go:171","msg":"trace[331603036] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25862; }","duration":"162.547896ms","start":"2026-08-04T22:27:02.250514Z","end":"2026-08-04T22:27:02.413062Z","steps":["trace[331603036] 'agreement among raft nodes before linearized reading' (duration: 162.499085ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:02.413144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.479901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-04T22:27:02.413161Z","caller":"traceutil/trace.go:171","msg":"trace[788330248] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:25862; }","duration":"166.498182ms","start":"2026-08-04T22:27:02.246659Z","end":"2026-08-04T22:27:02.413157Z","steps":["trace[788330248] 'agreement among raft nodes before linearized reading' (duration: 166.459831ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:02.699525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.536201ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-04T22:27:02.69971Z","caller":"traceutil/trace.go:171","msg":"trace[1877769997] linearizableReadLoop","detail":"{readStateIndex:26715; appliedIndex:26713; }","duration":"277.450429ms","start":"2026-08-04T22:27:02.422243Z","end":"2026-08-04T22:27:02.699694Z","steps":["trace[1877769997] 'read index received' (duration: 94.652862ms)","trace[1877769997] 'applied index is now lower than readState.Index' (duration: 182.796717ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T22:27:02.69984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.586972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-04T22:27:02.69988Z","caller":"traceutil/trace.go:171","msg":"trace[1343003667] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:25864; }","duration":"277.672794ms","start":"2026-08-04T22:27:02.422196Z","end":"2026-08-04T22:27:02.699869Z","steps":["trace[1343003667] 'agreement among raft nodes before linearized reading' (duration: 277.549081ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:02.699957Z","caller":"traceutil/trace.go:171","msg":"trace[1206860812] transaction","detail":"{read_only:false; response_revision:25863; number_of_response:1; }","duration":"282.025198ms","start":"2026-08-04T22:27:02.417887Z","end":"2026-08-04T22:27:02.699912Z","steps":["trace[1206860812] 'process raft request' (duration: 99.016777ms)","trace[1206860812] 'compare' (duration: 182.401927ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:27:02.699962Z","caller":"traceutil/trace.go:171","msg":"trace[2130087376] transaction","detail":"{read_only:false; response_revision:25864; number_of_response:1; }","duration":"281.488286ms","start":"2026-08-04T22:27:02.418426Z","end":"2026-08-04T22:27:02.699914Z","steps":["trace[2130087376] 'process raft request' (duration: 281.2121ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:03.022088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.962591ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-04T22:27:03.0222Z","caller":"traceutil/trace.go:171","msg":"trace[311740169] transaction","detail":"{read_only:false; response_revision:25865; number_of_response:1; }","duration":"303.407327ms","start":"2026-08-04T22:27:02.718773Z","end":"2026-08-04T22:27:03.02218Z","steps":["trace[311740169] 'process raft request' (duration: 99.609683ms)","trace[311740169] 'compare' (duration: 200.707629ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T22:27:03.02229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:02.718756Z","time spent":"303.49159ms","remote":"127.0.0.1:49070","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-08-04T22:27:03.352432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.506662ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-04T22:27:03.352674Z","caller":"traceutil/trace.go:171","msg":"trace[1310721500] transaction","detail":"{read_only:false; response_revision:25867; number_of_response:1; }","duration":"331.229791ms","start":"2026-08-04T22:27:03.021417Z","end":"2026-08-04T22:27:03.352647Z","steps":["trace[1310721500] 'process raft request' (duration: 228.445043ms)","trace[1310721500] 'compare' (duration: 102.413969ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T22:27:03.352802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.706208ms","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-08-04T22:27:03.352831Z","caller":"traceutil/trace.go:171","msg":"trace[1449524726] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25868; }","duration":"318.781179ms","start":"2026-08-04T22:27:03.034043Z","end":"2026-08-04T22:27:03.352824Z","steps":["trace[1449524726] 'agreement among raft nodes before linearized reading' (duration: 318.674296ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:03.352852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:03.033998Z","time spent":"318.848761ms","remote":"127.0.0.1:49070","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-08-04T22:27:03.352837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:03.021388Z","time spent":"331.339573ms","remote":"127.0.0.1:49070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T22:27:03.352696Z","caller":"traceutil/trace.go:171","msg":"trace[1629581927] linearizableReadLoop","detail":"{readStateIndex:26718; appliedIndex:26717; }","duration":"318.574833ms","start":"2026-08-04T22:27:03.034108Z","end":"2026-08-04T22:27:03.352683Z","steps":["trace[1629581927] 'read index received' (duration: 5.532333ms)","trace[1629581927] 'applied index is now lower than readState.Index' (duration: 313.04163ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:27:03.527777Z","caller":"traceutil/trace.go:171","msg":"trace[1096222265] transaction","detail":"{read_only:false; response_revision:25869; number_of_response:1; }","duration":"169.489065ms","start":"2026-08-04T22:27:03.35826Z","end":"2026-08-04T22:27:03.527749Z","steps":["trace[1096222265] 'process raft request' (duration: 132.317575ms)","trace[1096222265] 'compare' (duration: 37.058627ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T22:27:03.825145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.5056ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-04T22:27:03.825285Z","caller":"traceutil/trace.go:171","msg":"trace[370489144] transaction","detail":"{read_only:false; response_revision:25870; number_of_response:1; }","duration":"279.276153ms","start":"2026-08-04T22:27:03.545976Z","end":"2026-08-04T22:27:03.825252Z","steps":["trace[370489144] 'process raft request' (duration: 143.558407ms)","trace[370489144] 'compare' (duration: 135.038699ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:27:03.825325Z","caller":"traceutil/trace.go:171","msg":"trace[826554216] transaction","detail":"{read_only:false; response_revision:25871; number_of_response:1; }","duration":"258.551051ms","start":"2026-08-04T22:27:03.566757Z","end":"2026-08-04T22:27:03.825308Z","steps":["trace[826554216] 'process raft request' (duration: 258.498ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:03.825399Z","caller":"traceutil/trace.go:171","msg":"trace[1611093942] linearizableReadLoop","detail":"{readStateIndex:26721; appliedIndex:26720; }","duration":"258.888469ms","start":"2026-08-04T22:27:03.566482Z","end":"2026-08-04T22:27:03.825371Z","steps":["trace[1611093942] 'read index received' (duration: 123.236614ms)","trace[1611093942] 'applied index is now lower than readState.Index' (duration: 135.648124ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T22:27:03.825674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.171286ms","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-08-04T22:27:03.82572Z","caller":"traceutil/trace.go:171","msg":"trace[1970626748] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25871; }","duration":"259.286459ms","start":"2026-08-04T22:27:03.566423Z","end":"2026-08-04T22:27:03.825709Z","steps":["trace[1970626748] 'agreement among raft nodes before linearized reading' (duration: 259.099494ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:04.234699Z","caller":"traceutil/trace.go:171","msg":"trace[964041813] transaction","detail":"{read_only:false; response_revision:25872; number_of_response:1; }","duration":"400.256033ms","start":"2026-08-04T22:27:03.834419Z","end":"2026-08-04T22:27:04.234675Z","steps":["trace[964041813] 'process raft request' (duration: 400.093059ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:04.234849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:03.834354Z","time spent":"400.419696ms","remote":"127.0.0.1:49070","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-08-04T22:27:04.511145Z","caller":"traceutil/trace.go:171","msg":"trace[951435477] transaction","detail":"{read_only:false; response_revision:25873; number_of_response:1; }","duration":"559.030447ms","start":"2026-08-04T22:27:03.95209Z","end":"2026-08-04T22:27:04.51112Z","steps":["trace[951435477] 'process raft request' (duration: 535.839106ms)","trace[951435477] 'compare' (duration: 22.597677ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T22:27:04.511285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:03.952067Z","time spent":"559.14807ms","remote":"127.0.0.1:49070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T22:27:04.511295Z","caller":"traceutil/trace.go:171","msg":"trace[1506961698] linearizableReadLoop","detail":"{readStateIndex:26725; appliedIndex:26722; }","duration":"471.643721ms","start":"2026-08-04T22:27:04.039622Z","end":"2026-08-04T22:27:04.511265Z","steps":["trace[1506961698] 'read index received' (duration: 194.95984ms)","trace[1506961698] 'applied index is now lower than readState.Index' (duration: 276.682891ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:27:04.511432Z","caller":"traceutil/trace.go:171","msg":"trace[1764420920] transaction","detail":"{read_only:false; response_revision:25874; number_of_response:1; }","duration":"498.703616ms","start":"2026-08-04T22:27:04.012697Z","end":"2026-08-04T22:27:04.511401Z","steps":["trace[1764420920] 'process raft request' (duration: 498.375528ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:04.51148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.856126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.248\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-08-04T22:27:04.511512Z","caller":"traceutil/trace.go:171","msg":"trace[123217334] range","detail":"{range_begin:/registry/masterleases/199.204.45.248; range_end:; response_count:1; response_revision:25874; }","duration":"471.938437ms","start":"2026-08-04T22:27:04.039565Z","end":"2026-08-04T22:27:04.511503Z","steps":["trace[123217334] 'agreement among raft nodes before linearized reading' (duration: 471.826375ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:04.511535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:04.039539Z","time spent":"471.990799ms","remote":"127.0.0.1:48882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":163,"request content":"key:\"/registry/masterleases/199.204.45.248\" "} {"level":"warn","ts":"2026-08-04T22:27:04.511579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:04.012675Z","time spent":"498.824869ms","remote":"127.0.0.1:49070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T22:27:04.830332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.337062ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-04T22:27:04.830497Z","caller":"traceutil/trace.go:171","msg":"trace[1825838019] transaction","detail":"{read_only:false; response_revision:25875; number_of_response:1; }","duration":"412.664582ms","start":"2026-08-04T22:27:04.417809Z","end":"2026-08-04T22:27:04.830473Z","steps":["trace[1825838019] 'process raft request' (duration: 301.998352ms)","trace[1825838019] 'compare' (duration: 109.82391ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T22:27:04.830631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:04.417785Z","time spent":"412.773075ms","remote":"127.0.0.1:49070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T22:27:04.831209Z","caller":"traceutil/trace.go:171","msg":"trace[1556186665] linearizableReadLoop","detail":"{readStateIndex:26728; appliedIndex:26725; }","duration":"319.838424ms","start":"2026-08-04T22:27:04.511348Z","end":"2026-08-04T22:27:04.831187Z","steps":["trace[1556186665] 'read index received' (duration: 208.569061ms)","trace[1556186665] 'applied index is now lower than readState.Index' (duration: 111.267983ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:27:04.831337Z","caller":"traceutil/trace.go:171","msg":"trace[1940747154] transaction","detail":"{read_only:false; response_revision:25877; number_of_response:1; }","duration":"412.471547ms","start":"2026-08-04T22:27:04.41885Z","end":"2026-08-04T22:27:04.831322Z","steps":["trace[1940747154] 'process raft request' (duration: 412.283823ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:04.831392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:04.418841Z","time spent":"412.526539ms","remote":"127.0.0.1:49070","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-08-04T22:27:04.831444Z","caller":"traceutil/trace.go:171","msg":"trace[1002668936] transaction","detail":"{read_only:false; response_revision:25876; number_of_response:1; }","duration":"413.01011ms","start":"2026-08-04T22:27:04.418416Z","end":"2026-08-04T22:27:04.831426Z","steps":["trace[1002668936] 'process raft request' (duration: 412.584ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:04.831491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.113874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-04T22:27:04.83154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:04.418401Z","time spent":"413.091613ms","remote":"127.0.0.1:49070","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-08-04T22:27:04.831605Z","caller":"traceutil/trace.go:171","msg":"trace[307025063] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:25877; }","duration":"430.275478ms","start":"2026-08-04T22:27:04.401296Z","end":"2026-08-04T22:27:04.831572Z","steps":["trace[307025063] 'agreement among raft nodes before linearized reading' (duration: 430.088504ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:04.831667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:04.401276Z","time spent":"430.377541ms","remote":"127.0.0.1:41734","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/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-08-04T22:27:04.878955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.06218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-08-04T22:27:04.878987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:04.512423Z","time spent":"366.556327ms","remote":"127.0.0.1:48882","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-08-04T22:27:04.879034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.409813ms","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-08-04T22:27:04.879072Z","caller":"traceutil/trace.go:171","msg":"trace[501407214] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:25877; }","duration":"282.243244ms","start":"2026-08-04T22:27:04.596805Z","end":"2026-08-04T22:27:04.879048Z","steps":["trace[501407214] 'agreement among raft nodes before linearized reading' (duration: 281.956577ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:04.879119Z","caller":"traceutil/trace.go:171","msg":"trace[501151104] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25877; }","duration":"174.549146ms","start":"2026-08-04T22:27:04.704543Z","end":"2026-08-04T22:27:04.879092Z","steps":["trace[501151104] 'agreement among raft nodes before linearized reading' (duration: 174.252449ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:04.879458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.901287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-04T22:27:04.879509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.535101ms","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-08-04T22:27:04.87955Z","caller":"traceutil/trace.go:171","msg":"trace[512940511] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25877; }","duration":"175.673344ms","start":"2026-08-04T22:27:04.703867Z","end":"2026-08-04T22:27:04.87954Z","steps":["trace[512940511] 'agreement among raft nodes before linearized reading' (duration: 175.497809ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:04.879508Z","caller":"traceutil/trace.go:171","msg":"trace[545083797] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:25877; }","duration":"198.984069ms","start":"2026-08-04T22:27:04.680507Z","end":"2026-08-04T22:27:04.879491Z","steps":["trace[545083797] 'agreement among raft nodes before linearized reading' (duration: 198.902757ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:05.032766Z","caller":"traceutil/trace.go:171","msg":"trace[1070434036] transaction","detail":"{read_only:false; response_revision:25878; number_of_response:1; }","duration":"152.646886ms","start":"2026-08-04T22:27:04.880085Z","end":"2026-08-04T22:27:05.032732Z","steps":["trace[1070434036] 'process raft request' (duration: 95.426481ms)","trace[1070434036] 'compare' (duration: 56.942228ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:27:05.033192Z","caller":"traceutil/trace.go:171","msg":"trace[192890535] transaction","detail":"{read_only:false; response_revision:25880; number_of_response:1; }","duration":"148.371152ms","start":"2026-08-04T22:27:04.884806Z","end":"2026-08-04T22:27:05.033177Z","steps":["trace[192890535] 'process raft request' (duration: 147.8684ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:05.033357Z","caller":"traceutil/trace.go:171","msg":"trace[974666417] transaction","detail":"{read_only:false; response_revision:25879; number_of_response:1; }","duration":"149.1078ms","start":"2026-08-04T22:27:04.884225Z","end":"2026-08-04T22:27:05.033333Z","steps":["trace[974666417] 'process raft request' (duration: 148.386973ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:11.215368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.774824ms","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-08-04T22:27:11.215441Z","caller":"traceutil/trace.go:171","msg":"trace[699274388] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25921; }","duration":"158.922089ms","start":"2026-08-04T22:27:11.056503Z","end":"2026-08-04T22:27:11.215425Z","steps":["trace[699274388] 'range keys from in-memory index tree' (duration: 158.624021ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:11.215576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.754036ms","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-08-04T22:27:11.215664Z","caller":"traceutil/trace.go:171","msg":"trace[828696176] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25921; }","duration":"156.873449ms","start":"2026-08-04T22:27:11.058769Z","end":"2026-08-04T22:27:11.215643Z","steps":["trace[828696176] 'range keys from in-memory index tree' (duration: 156.599512ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:11.215655Z","caller":"traceutil/trace.go:171","msg":"trace[1033537197] linearizableReadLoop","detail":"{readStateIndex:26775; appliedIndex:26774; }","duration":"109.956223ms","start":"2026-08-04T22:27:11.105662Z","end":"2026-08-04T22:27:11.215618Z","steps":["trace[1033537197] 'read index received' (duration: 96.436635ms)","trace[1033537197] 'applied index is now lower than readState.Index' (duration: 13.517348ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:27:11.215781Z","caller":"traceutil/trace.go:171","msg":"trace[252451226] transaction","detail":"{read_only:false; response_revision:25922; number_of_response:1; }","duration":"111.623313ms","start":"2026-08-04T22:27:11.104099Z","end":"2026-08-04T22:27:11.215723Z","steps":["trace[252451226] 'process raft request' (duration: 98.083605ms)","trace[252451226] 'compare' (duration: 13.137198ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T22:27:11.215923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.243939ms","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-08-04T22:27:11.215992Z","caller":"traceutil/trace.go:171","msg":"trace[450954146] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25922; }","duration":"110.364982ms","start":"2026-08-04T22:27:11.105606Z","end":"2026-08-04T22:27:11.215971Z","steps":["trace[450954146] 'agreement among raft nodes before linearized reading' (duration: 110.137057ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:11.965766Z","caller":"traceutil/trace.go:171","msg":"trace[312180136] linearizableReadLoop","detail":"{readStateIndex:26779; appliedIndex:26779; }","duration":"399.826612ms","start":"2026-08-04T22:27:11.565923Z","end":"2026-08-04T22:27:11.965749Z","steps":["trace[312180136] 'read index received' (duration: 399.817472ms)","trace[312180136] 'applied index is now lower than readState.Index' (duration: 7.74µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:27:11.965764Z","caller":"traceutil/trace.go:171","msg":"trace[1816496177] transaction","detail":"{read_only:false; response_revision:25926; number_of_response:1; }","duration":"581.86262ms","start":"2026-08-04T22:27:11.383874Z","end":"2026-08-04T22:27:11.965737Z","steps":["trace[1816496177] 'process raft request' (duration: 581.704866ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:11.965925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:11.383845Z","time spent":"581.990093ms","remote":"127.0.0.1:49070","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-08-04T22:27:11.966035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.099428ms","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-08-04T22:27:11.966114Z","caller":"traceutil/trace.go:171","msg":"trace[1644905824] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25926; }","duration":"400.216491ms","start":"2026-08-04T22:27:11.565878Z","end":"2026-08-04T22:27:11.966094Z","steps":["trace[1644905824] 'agreement among raft nodes before linearized reading' (duration: 399.967155ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:11.966163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:11.565856Z","time spent":"400.296694ms","remote":"127.0.0.1:49070","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-08-04T22:27:12.353916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.019388ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-04T22:27:12.354094Z","caller":"traceutil/trace.go:171","msg":"trace[1573497486] linearizableReadLoop","detail":"{readStateIndex:26781; appliedIndex:26779; }","duration":"388.264332ms","start":"2026-08-04T22:27:11.965815Z","end":"2026-08-04T22:27:12.35408Z","steps":["trace[1573497486] 'read index received' (duration: 123.016499ms)","trace[1573497486] 'applied index is now lower than readState.Index' (duration: 265.246813ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:27:12.354167Z","caller":"traceutil/trace.go:171","msg":"trace[946174660] transaction","detail":"{read_only:false; response_revision:25927; number_of_response:1; }","duration":"502.835337ms","start":"2026-08-04T22:27:11.851324Z","end":"2026-08-04T22:27:12.354159Z","steps":["trace[946174660] 'process raft request' (duration: 237.483501ms)","trace[946174660] 'compare' (duration: 264.900635ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T22:27:12.354204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:11.851264Z","time spent":"502.918998ms","remote":"127.0.0.1:49070","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-08-04T22:27:12.354549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.22318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-08-04T22:27:12.354571Z","caller":"traceutil/trace.go:171","msg":"trace[1076087477] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25928; }","duration":"613.273111ms","start":"2026-08-04T22:27:11.741293Z","end":"2026-08-04T22:27:12.354566Z","steps":["trace[1076087477] 'agreement among raft nodes before linearized reading' (duration: 613.171358ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:12.354528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.546711ms","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":"warn","ts":"2026-08-04T22:27:12.354595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:11.741279Z","time spent":"613.312621ms","remote":"127.0.0.1:49004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12240,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-08-04T22:27:12.354623Z","caller":"traceutil/trace.go:171","msg":"trace[2071971001] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:25928; }","duration":"519.682024ms","start":"2026-08-04T22:27:11.834919Z","end":"2026-08-04T22:27:12.354601Z","steps":["trace[2071971001] 'agreement among raft nodes before linearized reading' (duration: 519.405568ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:12.354675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:11.834895Z","time spent":"519.771487ms","remote":"127.0.0.1:49070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":585,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-08-04T22:27:12.354674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.119887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-04T22:27:12.35474Z","caller":"traceutil/trace.go:171","msg":"trace[320219798] transaction","detail":"{read_only:false; response_revision:25928; number_of_response:1; }","duration":"500.637513ms","start":"2026-08-04T22:27:11.854077Z","end":"2026-08-04T22:27:12.354714Z","steps":["trace[320219798] 'process raft request' (duration: 499.926136ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:12.354757Z","caller":"traceutil/trace.go:171","msg":"trace[1216240371] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:25928; }","duration":"568.264861ms","start":"2026-08-04T22:27:11.786474Z","end":"2026-08-04T22:27:12.354739Z","steps":["trace[1216240371] 'agreement among raft nodes before linearized reading' (duration: 568.052326ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:12.354799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:11.786451Z","time spent":"568.336093ms","remote":"127.0.0.1:41668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-08-04T22:27:12.354853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:11.854052Z","time spent":"500.735186ms","remote":"127.0.0.1:49070","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-08-04T22:27:12.354878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.043887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1936"} {"level":"info","ts":"2026-08-04T22:27:12.35498Z","caller":"traceutil/trace.go:171","msg":"trace[1633219260] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:25928; }","duration":"540.15974ms","start":"2026-08-04T22:27:11.814795Z","end":"2026-08-04T22:27:12.354955Z","steps":["trace[1633219260] 'agreement among raft nodes before linearized reading' (duration: 539.879283ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:12.355052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:11.814773Z","time spent":"540.258833ms","remote":"127.0.0.1:48976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1959,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"warn","ts":"2026-08-04T22:27:12.354877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.40274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-04T22:27:12.355201Z","caller":"traceutil/trace.go:171","msg":"trace[984505723] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25928; }","duration":"503.699228ms","start":"2026-08-04T22:27:11.851416Z","end":"2026-08-04T22:27:12.355115Z","steps":["trace[984505723] 'agreement among raft nodes before linearized reading' (duration: 503.329509ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:12.355683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:11.851398Z","time spent":"503.891592ms","remote":"127.0.0.1:48842","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-08-04T22:27:12.359108Z","caller":"traceutil/trace.go:171","msg":"trace[1949060668] transaction","detail":"{read_only:false; response_revision:25929; number_of_response:1; }","duration":"388.532207ms","start":"2026-08-04T22:27:11.970551Z","end":"2026-08-04T22:27:12.359083Z","steps":["trace[1949060668] 'process raft request' (duration: 388.378174ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:12.359276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:11.970523Z","time spent":"388.664562ms","remote":"127.0.0.1:49070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T22:27:12.927573Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415874552520760610,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-04T22:27:13.094157Z","caller":"traceutil/trace.go:171","msg":"trace[1217500298] transaction","detail":"{read_only:false; response_revision:25931; number_of_response:1; }","duration":"731.088423ms","start":"2026-08-04T22:27:12.363039Z","end":"2026-08-04T22:27:13.094127Z","steps":["trace[1217500298] 'process raft request' (duration: 730.004686ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:13.094407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:12.363025Z","time spent":"731.245168ms","remote":"127.0.0.1:49070","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-08-04T22:27:13.096383Z","caller":"traceutil/trace.go:171","msg":"trace[1212003690] linearizableReadLoop","detail":"{readStateIndex:26789; appliedIndex:26783; }","duration":"669.521092ms","start":"2026-08-04T22:27:12.426844Z","end":"2026-08-04T22:27:13.096365Z","steps":["trace[1212003690] 'read index received' (duration: 666.186341ms)","trace[1212003690] 'applied index is now lower than readState.Index' (duration: 3.334031ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:27:13.096444Z","caller":"traceutil/trace.go:171","msg":"trace[1022006637] transaction","detail":"{read_only:false; response_revision:25936; number_of_response:1; }","duration":"225.958352ms","start":"2026-08-04T22:27:12.870477Z","end":"2026-08-04T22:27:13.096435Z","steps":["trace[1022006637] 'process raft request' (duration: 225.85988ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:13.096584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"669.715047ms","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-08-04T22:27:13.096382Z","caller":"traceutil/trace.go:171","msg":"trace[497249752] transaction","detail":"{read_only:false; response_revision:25933; number_of_response:1; }","duration":"363.085332ms","start":"2026-08-04T22:27:12.733271Z","end":"2026-08-04T22:27:13.096356Z","steps":["trace[497249752] 'process raft request' (duration: 362.98558ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:13.096671Z","caller":"traceutil/trace.go:171","msg":"trace[224284449] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25936; }","duration":"669.86052ms","start":"2026-08-04T22:27:12.426792Z","end":"2026-08-04T22:27:13.096652Z","steps":["trace[224284449] 'agreement among raft nodes before linearized reading' (duration: 669.662756ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:13.096783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:12.426765Z","time spent":"669.975563ms","remote":"127.0.0.1:49256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-08-04T22:27:13.096398Z","caller":"traceutil/trace.go:171","msg":"trace[4989924] transaction","detail":"{read_only:false; response_revision:25932; number_of_response:1; }","duration":"549.359383ms","start":"2026-08-04T22:27:12.546982Z","end":"2026-08-04T22:27:13.096342Z","steps":["trace[4989924] 'process raft request' (duration: 549.171318ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:13.096806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:12.733244Z","time spent":"363.472152ms","remote":"127.0.0.1:49070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T22:27:13.09688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:12.546954Z","time spent":"549.875945ms","remote":"127.0.0.1:49070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T22:27:13.096416Z","caller":"traceutil/trace.go:171","msg":"trace[899184177] transaction","detail":"{read_only:false; response_revision:25935; number_of_response:1; }","duration":"226.581877ms","start":"2026-08-04T22:27:12.86981Z","end":"2026-08-04T22:27:13.096392Z","steps":["trace[899184177] 'process raft request' (duration: 226.500325ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:13.096503Z","caller":"traceutil/trace.go:171","msg":"trace[824430432] transaction","detail":"{read_only:false; response_revision:25934; number_of_response:1; }","duration":"239.906979ms","start":"2026-08-04T22:27:12.856532Z","end":"2026-08-04T22:27:13.096439Z","steps":["trace[824430432] 'process raft request' (duration: 239.754726ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:13.096573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.08713ms","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":"info","ts":"2026-08-04T22:27:13.097253Z","caller":"traceutil/trace.go:171","msg":"trace[2088457379] 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:25936; }","duration":"372.768157ms","start":"2026-08-04T22:27:12.724457Z","end":"2026-08-04T22:27:13.097225Z","steps":["trace[2088457379] 'agreement among raft nodes before linearized reading' (duration: 372.06534ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:13.097304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:12.724391Z","time spent":"372.897129ms","remote":"127.0.0.1:59516","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":"info","ts":"2026-08-04T22:27:15.761415Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000068bc.wal"} {"level":"info","ts":"2026-08-04T22:27:19.275622Z","caller":"traceutil/trace.go:171","msg":"trace[117381791] linearizableReadLoop","detail":"{readStateIndex:26891; appliedIndex:26889; }","duration":"156.420357ms","start":"2026-08-04T22:27:19.119177Z","end":"2026-08-04T22:27:19.275597Z","steps":["trace[117381791] 'read index received' (duration: 8.856974ms)","trace[117381791] 'applied index is now lower than readState.Index' (duration: 147.562293ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:27:19.27596Z","caller":"traceutil/trace.go:171","msg":"trace[1696937121] transaction","detail":"{read_only:false; response_revision:26037; number_of_response:1; }","duration":"156.790416ms","start":"2026-08-04T22:27:19.119154Z","end":"2026-08-04T22:27:19.275945Z","steps":["trace[1696937121] 'process raft request' (duration: 156.196441ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:19.276187Z","caller":"traceutil/trace.go:171","msg":"trace[1118432103] transaction","detail":"{read_only:false; response_revision:26038; number_of_response:1; }","duration":"156.906989ms","start":"2026-08-04T22:27:19.119267Z","end":"2026-08-04T22:27:19.276174Z","steps":["trace[1118432103] 'process raft request' (duration: 156.242443ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:19.276286Z","caller":"traceutil/trace.go:171","msg":"trace[768175691] transaction","detail":"{read_only:false; response_revision:26039; number_of_response:1; }","duration":"153.167369ms","start":"2026-08-04T22:27:19.12309Z","end":"2026-08-04T22:27:19.276257Z","steps":["trace[768175691] 'process raft request' (duration: 152.469282ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:19.276417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.208106ms","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-08-04T22:27:19.276504Z","caller":"traceutil/trace.go:171","msg":"trace[869204467] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26039; }","duration":"157.34836ms","start":"2026-08-04T22:27:19.119134Z","end":"2026-08-04T22:27:19.276483Z","steps":["trace[869204467] 'agreement among raft nodes before linearized reading' (duration: 157.042143ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:19.305943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.350303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1d0b232a-845c-4040-b2ef-cda33a980ca8\" ","response":"range_response_count:1 size:3644"} {"level":"info","ts":"2026-08-04T22:27:19.306024Z","caller":"traceutil/trace.go:171","msg":"trace[448311823] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1d0b232a-845c-4040-b2ef-cda33a980ca8; range_end:; response_count:1; response_revision:26040; }","duration":"103.490996ms","start":"2026-08-04T22:27:19.202514Z","end":"2026-08-04T22:27:19.306005Z","steps":["trace[448311823] 'agreement among raft nodes before linearized reading' (duration: 103.25212ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:19.560689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.709084ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-04T22:27:19.560877Z","caller":"traceutil/trace.go:171","msg":"trace[495662847] transaction","detail":"{read_only:false; response_revision:26041; number_of_response:1; }","duration":"279.266692ms","start":"2026-08-04T22:27:19.281589Z","end":"2026-08-04T22:27:19.560856Z","steps":["trace[495662847] 'process raft request' (duration: 158.221941ms)","trace[495662847] 'compare' (duration: 120.503638ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:27:19.560939Z","caller":"traceutil/trace.go:171","msg":"trace[1510579934] linearizableReadLoop","detail":"{readStateIndex:26895; appliedIndex:26894; }","duration":"255.341733ms","start":"2026-08-04T22:27:19.305583Z","end":"2026-08-04T22:27:19.560924Z","steps":["trace[1510579934] 'read index received' (duration: 134.310493ms)","trace[1510579934] 'applied index is now lower than readState.Index' (duration: 121.02952ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:27:19.561052Z","caller":"traceutil/trace.go:171","msg":"trace[755638985] transaction","detail":"{read_only:false; response_revision:26043; number_of_response:1; }","duration":"250.620018ms","start":"2026-08-04T22:27:19.310415Z","end":"2026-08-04T22:27:19.561035Z","steps":["trace[755638985] 'process raft request' (duration: 250.526396ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:19.56111Z","caller":"traceutil/trace.go:171","msg":"trace[1182119979] transaction","detail":"{read_only:false; response_revision:26044; number_of_response:1; }","duration":"250.6847ms","start":"2026-08-04T22:27:19.310415Z","end":"2026-08-04T22:27:19.5611Z","steps":["trace[1182119979] 'process raft request' (duration: 250.574277ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:19.561195Z","caller":"traceutil/trace.go:171","msg":"trace[2004155487] transaction","detail":"{read_only:false; response_revision:26042; number_of_response:1; }","duration":"251.091889ms","start":"2026-08-04T22:27:19.310087Z","end":"2026-08-04T22:27:19.561179Z","steps":["trace[2004155487] 'process raft request' (duration: 250.772412ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:19.561063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.945942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-04T22:27:19.561301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.690589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1d0b232a-845c-4040-b2ef-cda33a980ca8\" ","response":"range_response_count:1 size:3644"} {"level":"info","ts":"2026-08-04T22:27:19.561308Z","caller":"traceutil/trace.go:171","msg":"trace[448307075] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26043; }","duration":"283.203598ms","start":"2026-08-04T22:27:19.27808Z","end":"2026-08-04T22:27:19.561283Z","steps":["trace[448307075] 'agreement among raft nodes before linearized reading' (duration: 282.917331ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:19.561342Z","caller":"traceutil/trace.go:171","msg":"trace[1206562163] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1d0b232a-845c-4040-b2ef-cda33a980ca8; range_end:; response_count:1; response_revision:26044; }","duration":"188.774761ms","start":"2026-08-04T22:27:19.372555Z","end":"2026-08-04T22:27:19.56133Z","steps":["trace[1206562163] 'agreement among raft nodes before linearized reading' (duration: 188.659168ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:19.728915Z","caller":"traceutil/trace.go:171","msg":"trace[751258820] transaction","detail":"{read_only:false; response_revision:26045; number_of_response:1; }","duration":"161.019638ms","start":"2026-08-04T22:27:19.567872Z","end":"2026-08-04T22:27:19.728892Z","steps":["trace[751258820] 'process raft request' (duration: 160.864655ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:20.036047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.023043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1634"} {"level":"info","ts":"2026-08-04T22:27:20.036153Z","caller":"traceutil/trace.go:171","msg":"trace[457141806] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:26045; }","duration":"207.184067ms","start":"2026-08-04T22:27:19.828955Z","end":"2026-08-04T22:27:20.036139Z","steps":["trace[457141806] 'range keys from in-memory index tree' (duration: 206.820498ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:20.287917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.532772ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-08-04T22:27:20.288705Z","caller":"traceutil/trace.go:171","msg":"trace[1839448587] linearizableReadLoop","detail":"{readStateIndex:26901; appliedIndex:26899; }","duration":"249.148453ms","start":"2026-08-04T22:27:20.039527Z","end":"2026-08-04T22:27:20.288676Z","steps":["trace[1839448587] 'read index received' (duration: 248.267012ms)","trace[1839448587] 'applied index is now lower than readState.Index' (duration: 879.341µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:27:20.28888Z","caller":"traceutil/trace.go:171","msg":"trace[307661697] transaction","detail":"{read_only:false; response_revision:26046; number_of_response:1; }","duration":"295.119605ms","start":"2026-08-04T22:27:19.993744Z","end":"2026-08-04T22:27:20.288863Z","steps":["trace[307661697] 'process raft request' (duration: 294.347007ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:20.404529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.917487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-04T22:27:20.4046Z","caller":"traceutil/trace.go:171","msg":"trace[870474949] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:26046; }","duration":"223.023549ms","start":"2026-08-04T22:27:20.181561Z","end":"2026-08-04T22:27:20.404584Z","steps":["trace[870474949] 'agreement among raft nodes before linearized reading' (duration: 107.41905ms)","trace[870474949] 'count revisions from in-memory index tree' (duration: 115.502287ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T22:27:20.40482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.290626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-fefe186f-7caf-4a82-8c1d-0b9364903cfb\" ","response":"range_response_count:1 size:1294"} {"level":"info","ts":"2026-08-04T22:27:20.40485Z","caller":"traceutil/trace.go:171","msg":"trace[1512628231] range","detail":"{range_begin:/registry/persistentvolumes/pvc-fefe186f-7caf-4a82-8c1d-0b9364903cfb; range_end:; response_count:1; response_revision:26046; }","duration":"365.346437ms","start":"2026-08-04T22:27:20.039492Z","end":"2026-08-04T22:27:20.404839Z","steps":["trace[1512628231] 'agreement among raft nodes before linearized reading' (duration: 249.496671ms)","trace[1512628231] 'range keys from in-memory index tree' (duration: 115.753253ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T22:27:20.404935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:20.039476Z","time spent":"365.452499ms","remote":"127.0.0.1:48970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1317,"request content":"key:\"/registry/persistentvolumes/pvc-fefe186f-7caf-4a82-8c1d-0b9364903cfb\" "} {"level":"warn","ts":"2026-08-04T22:27:22.837891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.266718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-04T22:27:22.837978Z","caller":"traceutil/trace.go:171","msg":"trace[1694402203] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:26065; }","duration":"169.403931ms","start":"2026-08-04T22:27:22.668553Z","end":"2026-08-04T22:27:22.837956Z","steps":["trace[1694402203] 'count revisions from in-memory index tree' (duration: 169.197996ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:22.837967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.501328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-04T22:27:22.838037Z","caller":"traceutil/trace.go:171","msg":"trace[2020608162] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:26065; }","duration":"248.621471ms","start":"2026-08-04T22:27:22.589397Z","end":"2026-08-04T22:27:22.838019Z","steps":["trace[2020608162] 'count revisions from in-memory index tree' (duration: 248.373925ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:27.779503Z","caller":"traceutil/trace.go:171","msg":"trace[2081247816] transaction","detail":"{read_only:false; response_revision:26127; number_of_response:1; }","duration":"176.420592ms","start":"2026-08-04T22:27:27.603059Z","end":"2026-08-04T22:27:27.779479Z","steps":["trace[2081247816] 'process raft request' (duration: 176.381791ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:27.779547Z","caller":"traceutil/trace.go:171","msg":"trace[1159889089] transaction","detail":"{read_only:false; response_revision:26125; number_of_response:1; }","duration":"178.633396ms","start":"2026-08-04T22:27:27.600891Z","end":"2026-08-04T22:27:27.779524Z","steps":["trace[1159889089] 'process raft request' (duration: 178.38789ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:27.779754Z","caller":"traceutil/trace.go:171","msg":"trace[440240507] transaction","detail":"{read_only:false; response_revision:26126; number_of_response:1; }","duration":"178.787569ms","start":"2026-08-04T22:27:27.600956Z","end":"2026-08-04T22:27:27.779744Z","steps":["trace[440240507] 'process raft request' (duration: 178.450511ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:32.7853Z","caller":"traceutil/trace.go:171","msg":"trace[637142402] transaction","detail":"{read_only:false; response_revision:26165; number_of_response:1; }","duration":"185.729747ms","start":"2026-08-04T22:27:32.599534Z","end":"2026-08-04T22:27:32.785263Z","steps":["trace[637142402] 'process raft request' (duration: 113.960399ms)","trace[637142402] 'compare' (duration: 71.619024ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:27:50.993068Z","caller":"traceutil/trace.go:171","msg":"trace[1567983213] transaction","detail":"{read_only:false; response_revision:26313; number_of_response:1; }","duration":"125.12056ms","start":"2026-08-04T22:27:50.867921Z","end":"2026-08-04T22:27:50.993042Z","steps":["trace[1567983213] 'process raft request' (duration: 124.914484ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:51.370642Z","caller":"traceutil/trace.go:171","msg":"trace[508627180] transaction","detail":"{read_only:false; response_revision:26314; number_of_response:1; }","duration":"138.726768ms","start":"2026-08-04T22:27:51.231872Z","end":"2026-08-04T22:27:51.370598Z","steps":["trace[508627180] 'process raft request' (duration: 138.289488ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:51.590141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.886437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-04T22:27:51.590236Z","caller":"traceutil/trace.go:171","msg":"trace[2066473004] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26314; }","duration":"218.01374ms","start":"2026-08-04T22:27:51.372189Z","end":"2026-08-04T22:27:51.590202Z","steps":["trace[2066473004] 'range keys from in-memory index tree' (duration: 217.812225ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:51.590509Z","caller":"traceutil/trace.go:171","msg":"trace[138147206] transaction","detail":"{read_only:false; response_revision:26315; number_of_response:1; }","duration":"211.592584ms","start":"2026-08-04T22:27:51.378871Z","end":"2026-08-04T22:27:51.590464Z","steps":["trace[138147206] 'process raft request' (duration: 114.762069ms)","trace[138147206] 'compare' (duration: 96.348704ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:27:51.663005Z","caller":"traceutil/trace.go:171","msg":"trace[306076006] linearizableReadLoop","detail":"{readStateIndex:27180; appliedIndex:27176; }","duration":"186.22895ms","start":"2026-08-04T22:27:51.47675Z","end":"2026-08-04T22:27:51.662979Z","steps":["trace[306076006] 'read index received' (duration: 16.858639ms)","trace[306076006] 'applied index is now lower than readState.Index' (duration: 169.369161ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T22:27:51.663207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.428545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-04T22:27:51.663251Z","caller":"traceutil/trace.go:171","msg":"trace[1089611233] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:26318; }","duration":"186.531108ms","start":"2026-08-04T22:27:51.476706Z","end":"2026-08-04T22:27:51.663238Z","steps":["trace[1089611233] 'agreement among raft nodes before linearized reading' (duration: 186.381854ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:51.663684Z","caller":"traceutil/trace.go:171","msg":"trace[498059935] transaction","detail":"{read_only:false; response_revision:26316; number_of_response:1; }","duration":"284.800837ms","start":"2026-08-04T22:27:51.378872Z","end":"2026-08-04T22:27:51.663672Z","steps":["trace[498059935] 'process raft request' (duration: 283.885925ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:51.663835Z","caller":"traceutil/trace.go:171","msg":"trace[1780162532] transaction","detail":"{read_only:false; response_revision:26317; number_of_response:1; }","duration":"268.102633ms","start":"2026-08-04T22:27:51.395722Z","end":"2026-08-04T22:27:51.663825Z","steps":["trace[1780162532] 'process raft request' (duration: 267.177931ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:51.664027Z","caller":"traceutil/trace.go:171","msg":"trace[1925365305] transaction","detail":"{read_only:false; response_revision:26318; number_of_response:1; }","duration":"263.916311ms","start":"2026-08-04T22:27:51.400097Z","end":"2026-08-04T22:27:51.664013Z","steps":["trace[1925365305] 'process raft request' (duration: 262.841015ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:51.895352Z","caller":"traceutil/trace.go:171","msg":"trace[1212458878] transaction","detail":"{read_only:false; response_revision:26319; number_of_response:1; }","duration":"114.279797ms","start":"2026-08-04T22:27:51.781036Z","end":"2026-08-04T22:27:51.895316Z","steps":["trace[1212458878] 'process raft request' (duration: 114.047672ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:52.160207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.397832ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-04T22:27:52.160322Z","caller":"traceutil/trace.go:171","msg":"trace[943813543] linearizableReadLoop","detail":"{readStateIndex:27182; appliedIndex:27181; }","duration":"199.439309ms","start":"2026-08-04T22:27:51.960866Z","end":"2026-08-04T22:27:52.160305Z","steps":["trace[943813543] 'read index received' (duration: 74.831673ms)","trace[943813543] 'applied index is now lower than readState.Index' (duration: 124.606456ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:27:52.160454Z","caller":"traceutil/trace.go:171","msg":"trace[1826340391] transaction","detail":"{read_only:false; response_revision:26320; number_of_response:1; }","duration":"211.87145ms","start":"2026-08-04T22:27:51.948526Z","end":"2026-08-04T22:27:52.160398Z","steps":["trace[1826340391] 'process raft request' (duration: 87.187741ms)","trace[1826340391] 'compare' (duration: 124.282639ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T22:27:52.160653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.203242ms","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-08-04T22:27:52.160699Z","caller":"traceutil/trace.go:171","msg":"trace[372890746] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26320; }","duration":"194.296005ms","start":"2026-08-04T22:27:51.96639Z","end":"2026-08-04T22:27:52.160686Z","steps":["trace[372890746] 'agreement among raft nodes before linearized reading' (duration: 194.148351ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:52.160842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.948911ms","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-08-04T22:27:52.161016Z","caller":"traceutil/trace.go:171","msg":"trace[874038504] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26320; }","duration":"200.119736ms","start":"2026-08-04T22:27:51.960833Z","end":"2026-08-04T22:27:52.160952Z","steps":["trace[874038504] 'agreement among raft nodes before linearized reading' (duration: 199.721686ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:52.467311Z","caller":"traceutil/trace.go:171","msg":"trace[1243719146] transaction","detail":"{read_only:false; response_revision:26321; number_of_response:1; }","duration":"302.569166ms","start":"2026-08-04T22:27:52.164708Z","end":"2026-08-04T22:27:52.467277Z","steps":["trace[1243719146] 'process raft request' (duration: 302.398872ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:52.467485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:52.164692Z","time spent":"302.70834ms","remote":"127.0.0.1:49070","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-08-04T22:27:52.500562Z","caller":"traceutil/trace.go:171","msg":"trace[814510622] transaction","detail":"{read_only:false; response_revision:26323; number_of_response:1; }","duration":"109.170484ms","start":"2026-08-04T22:27:52.391369Z","end":"2026-08-04T22:27:52.500539Z","steps":["trace[814510622] 'process raft request' (duration: 109.131253ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:52.50065Z","caller":"traceutil/trace.go:171","msg":"trace[2034954702] transaction","detail":"{read_only:false; response_revision:26322; number_of_response:1; }","duration":"334.940601ms","start":"2026-08-04T22:27:52.165674Z","end":"2026-08-04T22:27:52.500614Z","steps":["trace[2034954702] 'process raft request' (duration: 334.683264ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:27:52.500793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:27:52.165658Z","time spent":"335.046944ms","remote":"127.0.0.1:49070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T22:27:53.592201Z","caller":"traceutil/trace.go:171","msg":"trace[1366514127] transaction","detail":"{read_only:false; response_revision:26327; number_of_response:1; }","duration":"215.751034ms","start":"2026-08-04T22:27:53.37642Z","end":"2026-08-04T22:27:53.592171Z","steps":["trace[1366514127] 'process raft request' (duration: 215.55957ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:53.621847Z","caller":"traceutil/trace.go:171","msg":"trace[1552779629] transaction","detail":"{read_only:false; response_revision:26328; number_of_response:1; }","duration":"193.333732ms","start":"2026-08-04T22:27:53.428489Z","end":"2026-08-04T22:27:53.621822Z","steps":["trace[1552779629] 'process raft request' (duration: 193.191658ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:53.708371Z","caller":"traceutil/trace.go:171","msg":"trace[190511014] transaction","detail":"{read_only:false; response_revision:26329; number_of_response:1; }","duration":"112.069124ms","start":"2026-08-04T22:27:53.59627Z","end":"2026-08-04T22:27:53.708339Z","steps":["trace[190511014] 'process raft request' (duration: 90.44477ms)","trace[190511014] 'compare' (duration: 21.080251ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:27:53.892221Z","caller":"traceutil/trace.go:171","msg":"trace[1302084736] transaction","detail":"{read_only:false; response_revision:26330; number_of_response:1; }","duration":"219.312911ms","start":"2026-08-04T22:27:53.672887Z","end":"2026-08-04T22:27:53.8922Z","steps":["trace[1302084736] 'process raft request' (duration: 158.351575ms)","trace[1302084736] 'compare' (duration: 60.522755ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:27:53.892417Z","caller":"traceutil/trace.go:171","msg":"trace[632211038] transaction","detail":"{read_only:false; response_revision:26331; number_of_response:1; }","duration":"219.131957ms","start":"2026-08-04T22:27:53.673261Z","end":"2026-08-04T22:27:53.892393Z","steps":["trace[632211038] 'process raft request' (duration: 218.85539ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:53.892955Z","caller":"traceutil/trace.go:171","msg":"trace[479944088] transaction","detail":"{read_only:false; response_revision:26332; number_of_response:1; }","duration":"219.109206ms","start":"2026-08-04T22:27:53.673833Z","end":"2026-08-04T22:27:53.892942Z","steps":["trace[479944088] 'process raft request' (duration: 218.48154ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:54.302239Z","caller":"traceutil/trace.go:171","msg":"trace[1796888149] transaction","detail":"{read_only:false; response_revision:26335; number_of_response:1; }","duration":"103.712101ms","start":"2026-08-04T22:27:54.198454Z","end":"2026-08-04T22:27:54.302166Z","steps":["trace[1796888149] 'process raft request' (duration: 82.544879ms)","trace[1796888149] 'compare' (duration: 20.873725ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T22:27:54.704448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.635808ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-04T22:27:54.704546Z","caller":"traceutil/trace.go:171","msg":"trace[1871593838] transaction","detail":"{read_only:false; response_revision:26337; number_of_response:1; }","duration":"198.983978ms","start":"2026-08-04T22:27:54.505547Z","end":"2026-08-04T22:27:54.704531Z","steps":["trace[1871593838] 'process raft request' (duration: 88.186306ms)","trace[1871593838] 'compare' (duration: 110.475485ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:27:54.759699Z","caller":"traceutil/trace.go:171","msg":"trace[942714059] transaction","detail":"{read_only:false; response_revision:26338; number_of_response:1; }","duration":"197.937694ms","start":"2026-08-04T22:27:54.56174Z","end":"2026-08-04T22:27:54.759678Z","steps":["trace[942714059] 'process raft request' (duration: 197.78187ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:54.759917Z","caller":"traceutil/trace.go:171","msg":"trace[1191450005] transaction","detail":"{read_only:false; response_revision:26339; number_of_response:1; }","duration":"180.532401ms","start":"2026-08-04T22:27:54.579348Z","end":"2026-08-04T22:27:54.759881Z","steps":["trace[1191450005] 'process raft request' (duration: 180.293495ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:57.707791Z","caller":"traceutil/trace.go:171","msg":"trace[4408450] transaction","detail":"{read_only:false; response_revision:26358; number_of_response:1; }","duration":"105.961706ms","start":"2026-08-04T22:27:57.601791Z","end":"2026-08-04T22:27:57.707753Z","steps":["trace[4408450] 'process raft request' (duration: 105.675219ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:27:57.89176Z","caller":"traceutil/trace.go:171","msg":"trace[960431239] transaction","detail":"{read_only:false; response_revision:26359; number_of_response:1; }","duration":"174.168717ms","start":"2026-08-04T22:27:57.717566Z","end":"2026-08-04T22:27:57.891735Z","steps":["trace[960431239] 'process raft request' (duration: 142.962211ms)","trace[960431239] 'compare' (duration: 31.007681ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:28:08.206959Z","caller":"traceutil/trace.go:171","msg":"trace[2097051715] transaction","detail":"{read_only:false; response_revision:26442; number_of_response:1; }","duration":"223.172864ms","start":"2026-08-04T22:28:07.983758Z","end":"2026-08-04T22:28:08.206931Z","steps":["trace[2097051715] 'process raft request' (duration: 222.985649ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:28:08.314678Z","caller":"traceutil/trace.go:171","msg":"trace[1785862379] linearizableReadLoop","detail":"{readStateIndex:27310; appliedIndex:27306; }","duration":"253.070889ms","start":"2026-08-04T22:28:08.061587Z","end":"2026-08-04T22:28:08.314658Z","steps":["trace[1785862379] 'read index received' (duration: 145.187456ms)","trace[1785862379] 'applied index is now lower than readState.Index' (duration: 107.882633ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:28:08.31478Z","caller":"traceutil/trace.go:171","msg":"trace[296750370] transaction","detail":"{read_only:false; response_revision:26445; number_of_response:1; }","duration":"299.584745ms","start":"2026-08-04T22:28:08.015186Z","end":"2026-08-04T22:28:08.314771Z","steps":["trace[296750370] 'process raft request' (duration: 299.443092ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:28:08.314785Z","caller":"traceutil/trace.go:171","msg":"trace[919927447] transaction","detail":"{read_only:false; response_revision:26444; number_of_response:1; }","duration":"311.413351ms","start":"2026-08-04T22:28:08.003344Z","end":"2026-08-04T22:28:08.314758Z","steps":["trace[919927447] 'process raft request' (duration: 311.248607ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:28:08.31491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:28:08.003321Z","time spent":"311.524624ms","remote":"127.0.0.1:49070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":605,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T22:28:08.314976Z","caller":"traceutil/trace.go:171","msg":"trace[1455016296] transaction","detail":"{read_only:false; response_revision:26443; number_of_response:1; }","duration":"327.706395ms","start":"2026-08-04T22:28:07.987239Z","end":"2026-08-04T22:28:08.314946Z","steps":["trace[1455016296] 'process raft request' (duration: 318.902162ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:28:08.315019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.398697ms","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-08-04T22:28:08.315053Z","caller":"traceutil/trace.go:171","msg":"trace[1850492974] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26445; }","duration":"253.486548ms","start":"2026-08-04T22:28:08.061555Z","end":"2026-08-04T22:28:08.315041Z","steps":["trace[1850492974] 'agreement among raft nodes before linearized reading' (duration: 253.337455ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:28:08.315112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:28:07.987216Z","time spent":"327.824398ms","remote":"127.0.0.1:49070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T22:28:13.317645Z","caller":"traceutil/trace.go:171","msg":"trace[1348634093] transaction","detail":"{read_only:false; response_revision:26483; number_of_response:1; }","duration":"159.048701ms","start":"2026-08-04T22:28:13.158539Z","end":"2026-08-04T22:28:13.317588Z","steps":["trace[1348634093] 'process raft request' (duration: 158.751944ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:28:13.599804Z","caller":"traceutil/trace.go:171","msg":"trace[1513342041] linearizableReadLoop","detail":"{readStateIndex:27350; appliedIndex:27349; }","duration":"273.228276ms","start":"2026-08-04T22:28:13.326548Z","end":"2026-08-04T22:28:13.599776Z","steps":["trace[1513342041] 'read index received' (duration: 228.990005ms)","trace[1513342041] 'applied index is now lower than readState.Index' (duration: 44.237101ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:28:13.600099Z","caller":"traceutil/trace.go:171","msg":"trace[227983383] transaction","detail":"{read_only:false; response_revision:26484; number_of_response:1; }","duration":"275.959063ms","start":"2026-08-04T22:28:13.324119Z","end":"2026-08-04T22:28:13.600078Z","steps":["trace[227983383] 'process raft request' (duration: 231.380943ms)","trace[227983383] 'compare' (duration: 43.757429ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T22:28:13.600357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.78275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-04T22:28:13.600407Z","caller":"traceutil/trace.go:171","msg":"trace[1069245223] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:26484; }","duration":"273.855481ms","start":"2026-08-04T22:28:13.326535Z","end":"2026-08-04T22:28:13.600391Z","steps":["trace[1069245223] 'agreement among raft nodes before linearized reading' (duration: 273.757389ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:28:14.017407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.161175ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-04T22:28:14.01757Z","caller":"traceutil/trace.go:171","msg":"trace[1453010124] transaction","detail":"{read_only:false; response_revision:26485; number_of_response:1; }","duration":"352.998867ms","start":"2026-08-04T22:28:13.664523Z","end":"2026-08-04T22:28:14.017522Z","steps":["trace[1453010124] 'process raft request' (duration: 138.639416ms)","trace[1453010124] 'compare' (duration: 214.045673ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:28:14.017646Z","caller":"traceutil/trace.go:171","msg":"trace[752081933] linearizableReadLoop","detail":"{readStateIndex:27351; appliedIndex:27350; }","duration":"349.737239ms","start":"2026-08-04T22:28:13.667901Z","end":"2026-08-04T22:28:14.017638Z","steps":["trace[752081933] 'read index received' (duration: 135.503601ms)","trace[752081933] 'applied index is now lower than readState.Index' (duration: 214.232358ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T22:28:14.017745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.842171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-04T22:28:14.01778Z","caller":"traceutil/trace.go:171","msg":"trace[748895693] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:26486; }","duration":"349.914733ms","start":"2026-08-04T22:28:13.667855Z","end":"2026-08-04T22:28:14.01777Z","steps":["trace[748895693] 'agreement among raft nodes before linearized reading' (duration: 349.852652ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:28:14.017765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:28:13.664502Z","time spent":"353.150692ms","remote":"127.0.0.1:49070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T22:28:14.01782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:28:13.667842Z","time spent":"349.965824ms","remote":"127.0.0.1:41778","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/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"info","ts":"2026-08-04T22:28:14.017606Z","caller":"traceutil/trace.go:171","msg":"trace[1154718514] transaction","detail":"{read_only:false; response_revision:26486; number_of_response:1; }","duration":"237.574313ms","start":"2026-08-04T22:28:13.780014Z","end":"2026-08-04T22:28:14.017588Z","steps":["trace[1154718514] 'process raft request' (duration: 237.513321ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:28:14.018093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.444342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/auth-system/keycloak\" ","response":"range_response_count:1 size:906"} {"level":"info","ts":"2026-08-04T22:28:14.018122Z","caller":"traceutil/trace.go:171","msg":"trace[1187798847] range","detail":"{range_begin:/registry/serviceaccounts/auth-system/keycloak; range_end:; response_count:1; response_revision:26486; }","duration":"114.506153ms","start":"2026-08-04T22:28:13.903607Z","end":"2026-08-04T22:28:14.018113Z","steps":["trace[1187798847] 'agreement among raft nodes before linearized reading' (duration: 114.38757ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:28:14.018196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.521534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-04T22:28:14.018299Z","caller":"traceutil/trace.go:171","msg":"trace[1824141025] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:26486; }","duration":"107.663787ms","start":"2026-08-04T22:28:13.910617Z","end":"2026-08-04T22:28:14.018281Z","steps":["trace[1824141025] 'agreement among raft nodes before linearized reading' (duration: 107.522374ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:28:14.543523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.659439ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"info","ts":"2026-08-04T22:28:14.543786Z","caller":"traceutil/trace.go:171","msg":"trace[1881303572] transaction","detail":"{read_only:false; response_revision:26487; number_of_response:1; }","duration":"316.477774ms","start":"2026-08-04T22:28:14.227285Z","end":"2026-08-04T22:28:14.543763Z","steps":["trace[1881303572] 'process raft request' (duration: 316.33325ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:28:14.543907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:28:14.227266Z","time spent":"316.562725ms","remote":"127.0.0.1:49070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T22:28:14.543899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:28:14.051445Z","time spent":"492.448234ms","remote":"127.0.0.1:48882","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-08-04T22:28:14.732081Z","caller":"traceutil/trace.go:171","msg":"trace[1119316154] transaction","detail":"{read_only:false; response_revision:26488; number_of_response:1; }","duration":"399.114596ms","start":"2026-08-04T22:28:14.332883Z","end":"2026-08-04T22:28:14.731997Z","steps":["trace[1119316154] 'process raft request' (duration: 315.434509ms)","trace[1119316154] 'compare' (duration: 83.503831ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:28:14.732125Z","caller":"traceutil/trace.go:171","msg":"trace[980679354] transaction","detail":"{read_only:false; response_revision:26489; number_of_response:1; }","duration":"398.954752ms","start":"2026-08-04T22:28:14.333042Z","end":"2026-08-04T22:28:14.731996Z","steps":["trace[980679354] 'process raft request' (duration: 398.88964ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:28:14.732265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:28:14.332858Z","time spent":"399.31508ms","remote":"127.0.0.1:49070","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-08-04T22:28:14.732291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:28:14.333011Z","time spent":"399.188747ms","remote":"127.0.0.1:49070","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-08-04T22:28:14.732417Z","caller":"traceutil/trace.go:171","msg":"trace[120623161] linearizableReadLoop","detail":"{readStateIndex:27357; appliedIndex:27352; }","duration":"393.363766ms","start":"2026-08-04T22:28:14.339025Z","end":"2026-08-04T22:28:14.732389Z","steps":["trace[120623161] 'read index received' (duration: 34.511016ms)","trace[120623161] 'applied index is now lower than readState.Index' (duration: 358.85166ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:28:14.732568Z","caller":"traceutil/trace.go:171","msg":"trace[1757948409] transaction","detail":"{read_only:false; response_revision:26490; number_of_response:1; }","duration":"397.768502ms","start":"2026-08-04T22:28:14.334766Z","end":"2026-08-04T22:28:14.732534Z","steps":["trace[1757948409] 'process raft request' (duration: 397.197669ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:28:14.732681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.667114ms","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-08-04T22:28:14.73273Z","caller":"traceutil/trace.go:171","msg":"trace[224769928] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26490; }","duration":"393.745735ms","start":"2026-08-04T22:28:14.33897Z","end":"2026-08-04T22:28:14.732716Z","steps":["trace[224769928] 'agreement among raft nodes before linearized reading' (duration: 393.605691ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:28:14.732716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:28:14.334753Z","time spent":"397.873425ms","remote":"127.0.0.1:49070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T22:28:14.732761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:28:14.338952Z","time spent":"393.801487ms","remote":"127.0.0.1:49070","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":"info","ts":"2026-08-04T22:28:14.769373Z","caller":"traceutil/trace.go:171","msg":"trace[2000175174] transaction","detail":"{read_only:false; response_revision:26491; number_of_response:1; }","duration":"223.845321ms","start":"2026-08-04T22:28:14.545502Z","end":"2026-08-04T22:28:14.769347Z","steps":["trace[2000175174] 'process raft request' (duration: 223.704247ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:28:14.769536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.702203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-08-04T22:28:14.769611Z","caller":"traceutil/trace.go:171","msg":"trace[703637446] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26491; }","duration":"127.775384ms","start":"2026-08-04T22:28:14.641817Z","end":"2026-08-04T22:28:14.769592Z","steps":["trace[703637446] 'agreement among raft nodes before linearized reading' (duration: 127.60033ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:28:14.769535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.69391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-08-04T22:28:14.769724Z","caller":"traceutil/trace.go:171","msg":"trace[1086495356] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26491; }","duration":"352.937906ms","start":"2026-08-04T22:28:14.416768Z","end":"2026-08-04T22:28:14.769706Z","steps":["trace[1086495356] 'agreement among raft nodes before linearized reading' (duration: 352.564827ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:28:14.769781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T22:28:14.416736Z","time spent":"353.028629ms","remote":"127.0.0.1:49070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-04T22:28:14.770274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.964675ms","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-08-04T22:28:14.770379Z","caller":"traceutil/trace.go:171","msg":"trace[619204700] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26491; }","duration":"101.107829ms","start":"2026-08-04T22:28:14.669252Z","end":"2026-08-04T22:28:14.77036Z","steps":["trace[619204700] 'agreement among raft nodes before linearized reading' (duration: 100.109935ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:28:14.968478Z","caller":"traceutil/trace.go:171","msg":"trace[1263190572] linearizableReadLoop","detail":"{readStateIndex:27359; appliedIndex:27358; }","duration":"196.385956ms","start":"2026-08-04T22:28:14.772065Z","end":"2026-08-04T22:28:14.968451Z","steps":["trace[1263190572] 'read index received' (duration: 176.569296ms)","trace[1263190572] 'applied index is now lower than readState.Index' (duration: 19.81526ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T22:28:14.96852Z","caller":"traceutil/trace.go:171","msg":"trace[291408960] transaction","detail":"{read_only:false; response_revision:26492; number_of_response:1; }","duration":"231.431475ms","start":"2026-08-04T22:28:14.73706Z","end":"2026-08-04T22:28:14.968491Z","steps":["trace[291408960] 'process raft request' (duration: 211.565014ms)","trace[291408960] 'compare' (duration: 19.702347ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T22:28:14.968717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.628391ms","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-08-04T22:28:14.968757Z","caller":"traceutil/trace.go:171","msg":"trace[995929594] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:26492; }","duration":"196.727714ms","start":"2026-08-04T22:28:14.77202Z","end":"2026-08-04T22:28:14.968747Z","steps":["trace[995929594] 'agreement among raft nodes before linearized reading' (duration: 196.55343ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:28:15.022452Z","caller":"traceutil/trace.go:171","msg":"trace[1670327038] transaction","detail":"{read_only:false; response_revision:26494; number_of_response:1; }","duration":"248.062487ms","start":"2026-08-04T22:28:14.774363Z","end":"2026-08-04T22:28:15.022426Z","steps":["trace[1670327038] 'process raft request' (duration: 247.985005ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:28:15.022471Z","caller":"traceutil/trace.go:171","msg":"trace[150889854] transaction","detail":"{read_only:false; response_revision:26493; number_of_response:1; }","duration":"248.118518ms","start":"2026-08-04T22:28:14.774325Z","end":"2026-08-04T22:28:15.022444Z","steps":["trace[150889854] 'process raft request' (duration: 247.864072ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:28:15.022737Z","caller":"traceutil/trace.go:171","msg":"trace[879445196] transaction","detail":"{read_only:false; response_revision:26495; number_of_response:1; }","duration":"239.639073ms","start":"2026-08-04T22:28:14.783081Z","end":"2026-08-04T22:28:15.02272Z","steps":["trace[879445196] 'process raft request' (duration: 239.304625ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:28:15.023235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.894328ms","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-08-04T22:28:15.023307Z","caller":"traceutil/trace.go:171","msg":"trace[273193986] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:26497; }","duration":"120.99218ms","start":"2026-08-04T22:28:14.902294Z","end":"2026-08-04T22:28:15.023287Z","steps":["trace[273193986] 'agreement among raft nodes before linearized reading' (duration: 120.858146ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:28:15.023303Z","caller":"traceutil/trace.go:171","msg":"trace[119984421] transaction","detail":"{read_only:false; response_revision:26496; number_of_response:1; }","duration":"121.879342ms","start":"2026-08-04T22:28:14.901408Z","end":"2026-08-04T22:28:15.023287Z","steps":["trace[119984421] 'process raft request' (duration: 121.252906ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:28:15.0233Z","caller":"traceutil/trace.go:171","msg":"trace[1007095654] transaction","detail":"{read_only:false; response_revision:26497; number_of_response:1; }","duration":"107.607456ms","start":"2026-08-04T22:28:14.915634Z","end":"2026-08-04T22:28:15.023242Z","steps":["trace[1007095654] 'process raft request' (duration: 107.280437ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:28:15.02334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.766539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-08-04T22:28:15.023438Z","caller":"traceutil/trace.go:171","msg":"trace[702317495] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26497; }","duration":"249.900982ms","start":"2026-08-04T22:28:14.773516Z","end":"2026-08-04T22:28:15.023417Z","steps":["trace[702317495] 'agreement among raft nodes before linearized reading' (duration: 249.635305ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:28:15.023667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.310578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinepools/\" range_end:\"/registry/cluster.x-k8s.io/machinepools0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-04T22:28:15.023781Z","caller":"traceutil/trace.go:171","msg":"trace[1090840390] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinepools/; range_end:/registry/cluster.x-k8s.io/machinepools0; response_count:0; response_revision:26497; }","duration":"135.463471ms","start":"2026-08-04T22:28:14.8883Z","end":"2026-08-04T22:28:15.023764Z","steps":["trace[1090840390] 'agreement among raft nodes before linearized reading' (duration: 134.770494ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:28:15.023321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.489589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1782"} {"level":"info","ts":"2026-08-04T22:28:15.024665Z","caller":"traceutil/trace.go:171","msg":"trace[2085659153] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:26497; }","duration":"209.867932ms","start":"2026-08-04T22:28:14.814755Z","end":"2026-08-04T22:28:15.024623Z","steps":["trace[2085659153] 'agreement among raft nodes before linearized reading' (duration: 208.340744ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:28:15.238775Z","caller":"traceutil/trace.go:171","msg":"trace[1191160013] transaction","detail":"{read_only:false; response_revision:26498; number_of_response:1; }","duration":"211.119333ms","start":"2026-08-04T22:28:15.027626Z","end":"2026-08-04T22:28:15.238746Z","steps":["trace[1191160013] 'process raft request' (duration: 210.934158ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:28:15.261179Z","caller":"traceutil/trace.go:171","msg":"trace[2095457585] linearizableReadLoop","detail":"{readStateIndex:27366; appliedIndex:27364; }","duration":"178.633824ms","start":"2026-08-04T22:28:15.0825Z","end":"2026-08-04T22:28:15.261133Z","steps":["trace[2095457585] 'read index received' (duration: 156.072759ms)","trace[2095457585] 'applied index is now lower than readState.Index' (duration: 22.560245ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T22:28:15.261294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.774058ms","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-08-04T22:28:15.261317Z","caller":"traceutil/trace.go:171","msg":"trace[1697425106] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26499; }","duration":"178.849181ms","start":"2026-08-04T22:28:15.08246Z","end":"2026-08-04T22:28:15.261309Z","steps":["trace[1697425106] 'agreement among raft nodes before linearized reading' (duration: 178.781628ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:28:15.261353Z","caller":"traceutil/trace.go:171","msg":"trace[1674430272] transaction","detail":"{read_only:false; response_revision:26499; number_of_response:1; }","duration":"233.427523ms","start":"2026-08-04T22:28:15.027899Z","end":"2026-08-04T22:28:15.261327Z","steps":["trace[1674430272] 'process raft request' (duration: 233.099504ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T22:28:15.37139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.478628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-04T22:28:15.371505Z","caller":"traceutil/trace.go:171","msg":"trace[1879012185] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26499; }","duration":"106.686683ms","start":"2026-08-04T22:28:15.264791Z","end":"2026-08-04T22:28:15.371478Z","steps":["trace[1879012185] 'range keys from in-memory index tree' (duration: 106.358305ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:28:20.137303Z","caller":"traceutil/trace.go:171","msg":"trace[2090111839] transaction","detail":"{read_only:false; response_revision:26531; number_of_response:1; }","duration":"100.273818ms","start":"2026-08-04T22:28:20.036994Z","end":"2026-08-04T22:28:20.137268Z","steps":["trace[2090111839] 'process raft request' (duration: 100.042593ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:28:20.446761Z","caller":"traceutil/trace.go:171","msg":"trace[903865215] transaction","detail":"{read_only:false; response_revision:26532; number_of_response:1; }","duration":"111.971432ms","start":"2026-08-04T22:28:20.334763Z","end":"2026-08-04T22:28:20.446735Z","steps":["trace[903865215] 'process raft request' (duration: 111.338765ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:28:21.032567Z","caller":"traceutil/trace.go:171","msg":"trace[1668764314] transaction","detail":"{read_only:false; response_revision:26534; number_of_response:1; }","duration":"278.877364ms","start":"2026-08-04T22:28:20.753668Z","end":"2026-08-04T22:28:21.032545Z","steps":["trace[1668764314] 'process raft request' (duration: 278.753481ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:28:21.038908Z","caller":"traceutil/trace.go:171","msg":"trace[1301104016] transaction","detail":"{read_only:false; response_revision:26535; number_of_response:1; }","duration":"285.145815ms","start":"2026-08-04T22:28:20.753735Z","end":"2026-08-04T22:28:21.038881Z","steps":["trace[1301104016] 'process raft request' (duration: 284.841868ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:28:21.039073Z","caller":"traceutil/trace.go:171","msg":"trace[1318836591] transaction","detail":"{read_only:false; response_revision:26536; number_of_response:1; }","duration":"285.295119ms","start":"2026-08-04T22:28:20.753732Z","end":"2026-08-04T22:28:21.039027Z","steps":["trace[1318836591] 'process raft request' (duration: 285.009262ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:28:21.039139Z","caller":"traceutil/trace.go:171","msg":"trace[1632254955] transaction","detail":"{read_only:false; response_revision:26537; number_of_response:1; }","duration":"216.020551ms","start":"2026-08-04T22:28:20.82309Z","end":"2026-08-04T22:28:21.03911Z","steps":["trace[1632254955] 'process raft request' (duration: 215.697043ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T22:30:50.561106Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25181} {"level":"info","ts":"2026-08-04T22:30:50.702344Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25181,"took":"136.831124ms","hash":1467174849,"current-db-size-bytes":61984768,"current-db-size":"62 MB","current-db-size-in-use-bytes":37367808,"current-db-size-in-use":"37 MB"} {"level":"info","ts":"2026-08-04T22:30:50.702751Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1467174849,"revision":25181,"compact-revision":21967} {"level":"info","ts":"2026-08-04T22:32:34.105023Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"39582465ceaa2f67","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-04T22:32:34.111037Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-08-04T22:32:34.111129Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-08-04T22:35:50.567199Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28006} {"level":"info","ts":"2026-08-04T22:35:50.701811Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28006,"took":"130.132474ms","hash":539167558,"current-db-size-bytes":61984768,"current-db-size":"62 MB","current-db-size-in-use-bytes":33267712,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-08-04T22:35:50.701883Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":539167558,"revision":28006,"compact-revision":25181} {"level":"info","ts":"2026-08-04T22:40:50.573452Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30557} {"level":"info","ts":"2026-08-04T22:40:50.70563Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30557,"took":"128.138114ms","hash":1918335664,"current-db-size-bytes":61984768,"current-db-size":"62 MB","current-db-size-in-use-bytes":30670848,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-08-04T22:40:50.705707Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1918335664,"revision":30557,"compact-revision":28006} {"level":"info","ts":"2026-08-04T22:45:50.580658Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32816} {"level":"info","ts":"2026-08-04T22:45:50.727622Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32816,"took":"142.73987ms","hash":2398131726,"current-db-size-bytes":61984768,"current-db-size":"62 MB","current-db-size-in-use-bytes":30343168,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-04T22:45:50.727703Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2398131726,"revision":32816,"compact-revision":30557} {"level":"info","ts":"2026-08-04T22:50:50.586158Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35050} {"level":"info","ts":"2026-08-04T22:50:50.721741Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35050,"took":"131.977065ms","hash":2704551403,"current-db-size-bytes":61984768,"current-db-size":"62 MB","current-db-size-in-use-bytes":31559680,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-08-04T22:50:50.721799Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2704551403,"revision":35050,"compact-revision":32816} {"level":"info","ts":"2026-08-04T22:54:01.332753Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"39582465ceaa2f67","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-04T22:54:01.338455Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-08-04T22:54:01.338683Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-08-04T22:55:50.594345Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37350} {"level":"info","ts":"2026-08-04T22:55:50.716123Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37350,"took":"116.97644ms","hash":106926449,"current-db-size-bytes":62836736,"current-db-size":"63 MB","current-db-size-in-use-bytes":32550912,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-08-04T22:55:50.7162Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":106926449,"revision":37350,"compact-revision":35050}