{"level":"warn","ts":"2026-07-17T12:42:22.613228Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-17T12:42:22.613323Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.52:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.52:2380","--initial-cluster=instance=https://199.19.213.52:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.52:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.52:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-07-17T12:42:22.613391Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-17T12:42:22.613405Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.52:2380"]} {"level":"info","ts":"2026-07-17T12:42:22.613422Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-17T12:42:22.614085Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.52:2379"]} {"level":"info","ts":"2026-07-17T12:42:22.61416Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.52:2380"],"listen-peer-urls":["https://199.19.213.52:2380"],"advertise-client-urls":["https://199.19.213.52:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.52:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.52:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-07-17T12:42:22.618252Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.860926ms"} {"level":"info","ts":"2026-07-17T12:42:22.623331Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e1254347e028571c","cluster-id":"fc1f90ba5bf7591c"} {"level":"info","ts":"2026-07-17T12:42:22.62347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1254347e028571c switched to configuration voters=()"} {"level":"info","ts":"2026-07-17T12:42:22.623512Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1254347e028571c became follower at term 0"} {"level":"info","ts":"2026-07-17T12:42:22.623532Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e1254347e028571c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-17T12:42:22.623556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1254347e028571c became follower at term 1"} {"level":"info","ts":"2026-07-17T12:42:22.623611Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1254347e028571c switched to configuration voters=(16223447208654559004)"} {"level":"warn","ts":"2026-07-17T12:42:22.628378Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-17T12:42:22.630128Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-17T12:42:22.631568Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-07-17T12:42:22.63541Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e1254347e028571c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-17T12:42:22.635552Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e1254347e028571c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-17T12:42:22.635662Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-17T12:42:22.635792Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-17T12:42:22.635805Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-17T12:42:22.64603Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1254347e028571c switched to configuration voters=(16223447208654559004)"} {"level":"info","ts":"2026-07-17T12:42:22.646172Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fc1f90ba5bf7591c","local-member-id":"e1254347e028571c","added-peer-id":"e1254347e028571c","added-peer-peer-urls":["https://199.19.213.52:2380"]} {"level":"info","ts":"2026-07-17T12:42:22.650518Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.52:2380"} {"level":"info","ts":"2026-07-17T12:42:22.650559Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.52:2380"} {"level":"info","ts":"2026-07-17T12:42:22.650466Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-17T12:42:22.650869Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e1254347e028571c","initial-advertise-peer-urls":["https://199.19.213.52:2380"],"listen-peer-urls":["https://199.19.213.52:2380"],"advertise-client-urls":["https://199.19.213.52:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.52:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-17T12:42:22.650918Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-17T12:42:23.524165Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1254347e028571c is starting a new election at term 1"} {"level":"info","ts":"2026-07-17T12:42:23.524218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1254347e028571c became pre-candidate at term 1"} {"level":"info","ts":"2026-07-17T12:42:23.524244Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1254347e028571c received MsgPreVoteResp from e1254347e028571c at term 1"} {"level":"info","ts":"2026-07-17T12:42:23.524264Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1254347e028571c became candidate at term 2"} {"level":"info","ts":"2026-07-17T12:42:23.52428Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1254347e028571c received MsgVoteResp from e1254347e028571c at term 2"} {"level":"info","ts":"2026-07-17T12:42:23.524322Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1254347e028571c became leader at term 2"} {"level":"info","ts":"2026-07-17T12:42:23.52434Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e1254347e028571c elected leader e1254347e028571c at term 2"} {"level":"info","ts":"2026-07-17T12:42:23.525779Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e1254347e028571c","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.52:2379]}","request-path":"/0/members/e1254347e028571c/attributes","cluster-id":"fc1f90ba5bf7591c","publish-timeout":"7s"} {"level":"info","ts":"2026-07-17T12:42:23.525813Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-17T12:42:23.525975Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-17T12:42:23.526272Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-17T12:42:23.526447Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-17T12:42:23.526469Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-17T12:42:23.528192Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.52:2379"} {"level":"info","ts":"2026-07-17T12:42:23.529043Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-17T12:42:23.536237Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fc1f90ba5bf7591c","local-member-id":"e1254347e028571c","cluster-version":"3.5"} {"level":"info","ts":"2026-07-17T12:42:23.5364Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-17T12:42:23.536477Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-17T12:43:09.282391Z","caller":"traceutil/trace.go:171","msg":"trace[128690643] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"143.187488ms","start":"2026-07-17T12:43:09.139168Z","end":"2026-07-17T12:43:09.282356Z","steps":["trace[128690643] 'process raft request' (duration: 106.252832ms)","trace[128690643] 'compare' (duration: 36.802952ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T12:43:09.550859Z","caller":"traceutil/trace.go:171","msg":"trace[364444114] linearizableReadLoop","detail":"{readStateIndex:626; appliedIndex:624; }","duration":"257.342047ms","start":"2026-07-17T12:43:09.293486Z","end":"2026-07-17T12:43:09.550828Z","steps":["trace[364444114] 'read index received' (duration: 85.80536ms)","trace[364444114] 'applied index is now lower than readState.Index' (duration: 171.535847ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T12:43:09.550939Z","caller":"traceutil/trace.go:171","msg":"trace[2071981601] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"260.234568ms","start":"2026-07-17T12:43:09.290674Z","end":"2026-07-17T12:43:09.550909Z","steps":["trace[2071981601] 'process raft request' (duration: 260.106504ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T12:43:09.550939Z","caller":"traceutil/trace.go:171","msg":"trace[1248047725] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"261.683007ms","start":"2026-07-17T12:43:09.289201Z","end":"2026-07-17T12:43:09.550884Z","steps":["trace[1248047725] 'process raft request' (duration: 261.406659ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:43:09.551036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.509862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T12:43:09.551157Z","caller":"traceutil/trace.go:171","msg":"trace[1961780822] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:604; }","duration":"257.661307ms","start":"2026-07-17T12:43:09.29348Z","end":"2026-07-17T12:43:09.551142Z","steps":["trace[1961780822] 'agreement among raft nodes before linearized reading' (duration: 257.483702ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T12:43:09.72602Z","caller":"traceutil/trace.go:171","msg":"trace[1824231473] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"152.633848ms","start":"2026-07-17T12:43:09.573361Z","end":"2026-07-17T12:43:09.725994Z","steps":["trace[1824231473] 'process raft request' (duration: 152.485744ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T12:43:10.204228Z","caller":"traceutil/trace.go:171","msg":"trace[1923855483] linearizableReadLoop","detail":"{readStateIndex:629; appliedIndex:628; }","duration":"211.421594ms","start":"2026-07-17T12:43:09.99278Z","end":"2026-07-17T12:43:10.204202Z","steps":["trace[1923855483] 'read index received' (duration: 210.513089ms)","trace[1923855483] 'applied index is now lower than readState.Index' (duration: 907.385µs)"],"step_count":2} {"level":"warn","ts":"2026-07-17T12:43:10.204353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.549799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T12:43:10.204385Z","caller":"traceutil/trace.go:171","msg":"trace[1232639856] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:607; }","duration":"211.637771ms","start":"2026-07-17T12:43:09.992736Z","end":"2026-07-17T12:43:10.204374Z","steps":["trace[1232639856] 'agreement among raft nodes before linearized reading' (duration: 211.562269ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T12:43:10.20462Z","caller":"traceutil/trace.go:171","msg":"trace[1019620160] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"246.718446ms","start":"2026-07-17T12:43:09.957868Z","end":"2026-07-17T12:43:10.204586Z","steps":["trace[1019620160] 'process raft request' (duration: 245.712838ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T12:43:24.503399Z","caller":"traceutil/trace.go:171","msg":"trace[669213563] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"165.836191ms","start":"2026-07-17T12:43:24.337537Z","end":"2026-07-17T12:43:24.503373Z","steps":["trace[669213563] 'process raft request' (duration: 165.698657ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T12:44:42.804407Z","caller":"traceutil/trace.go:171","msg":"trace[717399995] transaction","detail":"{read_only:false; response_revision:1849; number_of_response:1; }","duration":"136.658948ms","start":"2026-07-17T12:44:42.667713Z","end":"2026-07-17T12:44:42.804371Z","steps":["trace[717399995] 'process raft request' (duration: 136.445592ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T12:45:28.019922Z","caller":"traceutil/trace.go:171","msg":"trace[718437540] transaction","detail":"{read_only:false; response_revision:2143; number_of_response:1; }","duration":"135.783483ms","start":"2026-07-17T12:45:27.88409Z","end":"2026-07-17T12:45:28.019874Z","steps":["trace[718437540] 'process raft request' (duration: 71.518422ms)","trace[718437540] 'compare' (duration: 64.066355ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T12:45:34.374406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.603063ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-17T12:45:34.374665Z","caller":"traceutil/trace.go:171","msg":"trace[451485182] transaction","detail":"{read_only:false; response_revision:2177; number_of_response:1; }","duration":"243.093308ms","start":"2026-07-17T12:45:34.131539Z","end":"2026-07-17T12:45:34.374632Z","steps":["trace[451485182] 'process raft request' (duration: 112.641792ms)","trace[451485182] 'compare' (duration: 129.433918ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T12:45:34.374725Z","caller":"traceutil/trace.go:171","msg":"trace[1555588910] transaction","detail":"{read_only:false; response_revision:2178; number_of_response:1; }","duration":"234.058277ms","start":"2026-07-17T12:45:34.140652Z","end":"2026-07-17T12:45:34.37471Z","steps":["trace[1555588910] 'process raft request' (duration: 233.896283ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T12:45:34.374766Z","caller":"traceutil/trace.go:171","msg":"trace[1358364167] linearizableReadLoop","detail":"{readStateIndex:2260; appliedIndex:2259; }","duration":"238.673175ms","start":"2026-07-17T12:45:34.136051Z","end":"2026-07-17T12:45:34.374724Z","steps":["trace[1358364167] 'read index received' (duration: 108.26857ms)","trace[1358364167] 'applied index is now lower than readState.Index' (duration: 130.399655ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T12:45:34.375168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.449103ms","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-07-17T12:45:34.375215Z","caller":"traceutil/trace.go:171","msg":"trace[594175727] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2178; }","duration":"280.592457ms","start":"2026-07-17T12:45:34.09461Z","end":"2026-07-17T12:45:34.375203Z","steps":["trace[594175727] 'agreement among raft nodes before linearized reading' (duration: 280.313279ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T12:45:34.517397Z","caller":"traceutil/trace.go:171","msg":"trace[529559470] transaction","detail":"{read_only:false; response_revision:2179; number_of_response:1; }","duration":"137.045068ms","start":"2026-07-17T12:45:34.380325Z","end":"2026-07-17T12:45:34.51737Z","steps":["trace[529559470] 'process raft request' (duration: 129.332934ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T12:45:34.517933Z","caller":"traceutil/trace.go:171","msg":"trace[441590089] transaction","detail":"{read_only:false; response_revision:2181; number_of_response:1; }","duration":"137.324485ms","start":"2026-07-17T12:45:34.380574Z","end":"2026-07-17T12:45:34.517898Z","steps":["trace[441590089] 'process raft request' (duration: 137.256823ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T12:45:34.517971Z","caller":"traceutil/trace.go:171","msg":"trace[74655245] transaction","detail":"{read_only:false; response_revision:2180; number_of_response:1; }","duration":"137.48352ms","start":"2026-07-17T12:45:34.38047Z","end":"2026-07-17T12:45:34.517953Z","steps":["trace[74655245] 'process raft request' (duration: 137.215432ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T12:51:01.504186Z","caller":"traceutil/trace.go:171","msg":"trace[1130658505] transaction","detail":"{read_only:false; response_revision:4911; number_of_response:1; }","duration":"101.569777ms","start":"2026-07-17T12:51:01.402587Z","end":"2026-07-17T12:51:01.504156Z","steps":["trace[1130658505] 'process raft request' (duration: 101.143305ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:04.648562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.849369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-17T12:51:04.648653Z","caller":"traceutil/trace.go:171","msg":"trace[1528699139] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5047; }","duration":"244.995433ms","start":"2026-07-17T12:51:04.403639Z","end":"2026-07-17T12:51:04.648634Z","steps":["trace[1528699139] 'range keys from in-memory index tree' (duration: 244.646483ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:04.648897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.450368ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-17T12:51:04.649018Z","caller":"traceutil/trace.go:171","msg":"trace[1380756804] transaction","detail":"{read_only:false; response_revision:5048; number_of_response:1; }","duration":"134.419113ms","start":"2026-07-17T12:51:04.514579Z","end":"2026-07-17T12:51:04.648998Z","steps":["trace[1380756804] 'process raft request' (duration: 18.789301ms)","trace[1380756804] 'compare' (duration: 115.299493ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T12:51:04.666747Z","caller":"traceutil/trace.go:171","msg":"trace[1131163638] transaction","detail":"{read_only:false; response_revision:5049; number_of_response:1; }","duration":"139.299171ms","start":"2026-07-17T12:51:04.527417Z","end":"2026-07-17T12:51:04.666716Z","steps":["trace[1131163638] 'process raft request' (duration: 139.096865ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:06.761079Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6277067284459441045,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-17T12:51:06.809918Z","caller":"traceutil/trace.go:171","msg":"trace[87586992] transaction","detail":"{read_only:false; response_revision:5077; number_of_response:1; }","duration":"560.762953ms","start":"2026-07-17T12:51:06.249129Z","end":"2026-07-17T12:51:06.809892Z","steps":["trace[87586992] 'process raft request' (duration: 560.597318ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:06.810092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:06.249109Z","time spent":"560.891417ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T12:51:07.61706Z","caller":"traceutil/trace.go:171","msg":"trace[334697711] linearizableReadLoop","detail":"{readStateIndex:5268; appliedIndex:5265; }","duration":"1.356052582s","start":"2026-07-17T12:51:06.260992Z","end":"2026-07-17T12:51:07.617045Z","steps":["trace[334697711] 'read index received' (duration: 548.746634ms)","trace[334697711] 'applied index is now lower than readState.Index' (duration: 807.305128ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T12:51:07.617244Z","caller":"traceutil/trace.go:171","msg":"trace[1946489870] transaction","detail":"{read_only:false; response_revision:5078; number_of_response:1; }","duration":"963.486375ms","start":"2026-07-17T12:51:06.653749Z","end":"2026-07-17T12:51:07.617235Z","steps":["trace[1946489870] 'process raft request' (duration: 963.185287ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:07.617317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:06.653725Z","time spent":"963.542437ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T12:51:07.617431Z","caller":"traceutil/trace.go:171","msg":"trace[700635871] transaction","detail":"{read_only:false; response_revision:5079; number_of_response:1; }","duration":"945.737885ms","start":"2026-07-17T12:51:06.671687Z","end":"2026-07-17T12:51:07.617425Z","steps":["trace[700635871] 'process raft request' (duration: 945.332153ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:07.617462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:06.671668Z","time spent":"945.776065ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T12:51:07.617606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.356619929s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-17T12:51:07.617627Z","caller":"traceutil/trace.go:171","msg":"trace[1164078160] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5079; }","duration":"1.35666632s","start":"2026-07-17T12:51:06.260954Z","end":"2026-07-17T12:51:07.617621Z","steps":["trace[1164078160] 'agreement among raft nodes before linearized reading' (duration: 1.356590388s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:07.617646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:06.260938Z","time spent":"1.356704551s","remote":"127.0.0.1:33904","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":"warn","ts":"2026-07-17T12:51:07.633302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.360822907s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-17T12:51:07.633375Z","caller":"traceutil/trace.go:171","msg":"trace[956249640] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5081; }","duration":"1.36094652s","start":"2026-07-17T12:51:06.272413Z","end":"2026-07-17T12:51:07.63336Z","steps":["trace[956249640] 'agreement among raft nodes before linearized reading' (duration: 1.360713064s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:07.633412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:06.27239Z","time spent":"1.361015683s","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-17T12:51:07.633792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.41111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5993be03-02ce-4394-ae40-3f3c59ac0d63\" ","response":"range_response_count:1 size:3893"} {"level":"info","ts":"2026-07-17T12:51:07.633821Z","caller":"traceutil/trace.go:171","msg":"trace[1750728318] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5993be03-02ce-4394-ae40-3f3c59ac0d63; range_end:; response_count:1; response_revision:5081; }","duration":"415.477112ms","start":"2026-07-17T12:51:07.218335Z","end":"2026-07-17T12:51:07.633813Z","steps":["trace[1750728318] 'agreement among raft nodes before linearized reading' (duration: 415.40856ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:07.633855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:07.218314Z","time spent":"415.529034ms","remote":"127.0.0.1:33816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3917,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5993be03-02ce-4394-ae40-3f3c59ac0d63\" "} {"level":"warn","ts":"2026-07-17T12:51:07.634335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.289649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:786853"} {"level":"info","ts":"2026-07-17T12:51:07.634383Z","caller":"traceutil/trace.go:171","msg":"trace[1728297644] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5081; }","duration":"605.369701ms","start":"2026-07-17T12:51:07.029Z","end":"2026-07-17T12:51:07.634369Z","steps":["trace[1728297644] 'agreement among raft nodes before linearized reading' (duration: 604.99823ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:07.63436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"953.068092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.52\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-07-17T12:51:07.634415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:07.028972Z","time spent":"605.431912ms","remote":"127.0.0.1:33754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":25,"response size":786877,"request content":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" "} {"level":"info","ts":"2026-07-17T12:51:07.634443Z","caller":"traceutil/trace.go:171","msg":"trace[1834088353] range","detail":"{range_begin:/registry/masterleases/199.19.213.52; range_end:; response_count:1; response_revision:5081; }","duration":"953.166994ms","start":"2026-07-17T12:51:06.681256Z","end":"2026-07-17T12:51:07.634423Z","steps":["trace[1834088353] 'agreement among raft nodes before linearized reading' (duration: 952.918527ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:07.63449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:06.68124Z","time spent":"953.240507ms","remote":"127.0.0.1:33700","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.19.213.52\" "} {"level":"warn","ts":"2026-07-17T12:51:07.634715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"643.734223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T12:51:07.634772Z","caller":"traceutil/trace.go:171","msg":"trace[762548715] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5081; }","duration":"643.814426ms","start":"2026-07-17T12:51:06.990947Z","end":"2026-07-17T12:51:07.634761Z","steps":["trace[762548715] 'agreement among raft nodes before linearized reading' (duration: 643.738654ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:07.634812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:06.99093Z","time spent":"643.876037ms","remote":"127.0.0.1:33658","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-07-17T12:51:07.635009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"684.591866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-17T12:51:07.635051Z","caller":"traceutil/trace.go:171","msg":"trace[315318895] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5081; }","duration":"684.630267ms","start":"2026-07-17T12:51:06.950409Z","end":"2026-07-17T12:51:07.635039Z","steps":["trace[315318895] 'agreement among raft nodes before linearized reading' (duration: 684.533094ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:07.635085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:06.950333Z","time spent":"684.745411ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-17T12:51:07.635274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"925.491023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-17T12:51:07.63531Z","caller":"traceutil/trace.go:171","msg":"trace[118711062] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5081; }","duration":"925.563335ms","start":"2026-07-17T12:51:06.709738Z","end":"2026-07-17T12:51:07.635301Z","steps":["trace[118711062] 'agreement among raft nodes before linearized reading' (duration: 925.469822ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:07.635347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:06.709717Z","time spent":"925.620747ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-17T12:51:08.552146Z","caller":"traceutil/trace.go:171","msg":"trace[1921159798] transaction","detail":"{read_only:false; response_revision:5083; number_of_response:1; }","duration":"908.185876ms","start":"2026-07-17T12:51:07.643916Z","end":"2026-07-17T12:51:08.552102Z","steps":["trace[1921159798] 'process raft request' (duration: 907.909409ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:08.552312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:07.643895Z","time spent":"908.32722ms","remote":"127.0.0.1:33700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T12:51:11.695382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000719902s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-17T12:51:11.695489Z","caller":"traceutil/trace.go:171","msg":"trace[717173653] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000875037s","start":"2026-07-17T12:51:09.694587Z","end":"2026-07-17T12:51:11.695463Z","steps":["trace[717173653] 'agreement among raft nodes before linearized reading' (duration: 2.000732953s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:11.695548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:09.694547Z","time spent":"2.00098851s","remote":"127.0.0.1:33658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/07/17 12:51:11 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-17T12:51:11.780444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.035837603s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T12:51:11.780544Z","caller":"traceutil/trace.go:171","msg":"trace[935895329] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5083; }","duration":"2.035945966s","start":"2026-07-17T12:51:09.744581Z","end":"2026-07-17T12:51:11.780527Z","steps":["trace[935895329] 'range keys from in-memory index tree' (duration: 2.035821363s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:11.780786Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.228193788s","expected-duration":"1s"} {"level":"info","ts":"2026-07-17T12:51:11.781397Z","caller":"traceutil/trace.go:171","msg":"trace[39759323] transaction","detail":"{read_only:false; response_revision:5084; number_of_response:1; }","duration":"3.231574603s","start":"2026-07-17T12:51:08.549811Z","end":"2026-07-17T12:51:11.781386Z","steps":["trace[39759323] 'process raft request' (duration: 3.231264884s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:11.781479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:08.549789Z","time spent":"3.231638155s","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T12:51:11.781541Z","caller":"traceutil/trace.go:171","msg":"trace[730222400] linearizableReadLoop","detail":"{readStateIndex:5275; appliedIndex:5273; }","duration":"3.231013317s","start":"2026-07-17T12:51:08.550502Z","end":"2026-07-17T12:51:11.781515Z","steps":["trace[730222400] 'read index received' (duration: 2.084109ms)","trace[730222400] 'applied index is now lower than readState.Index' (duration: 3.228928158s)"],"step_count":2} {"level":"info","ts":"2026-07-17T12:51:11.781421Z","caller":"traceutil/trace.go:171","msg":"trace[489115703] transaction","detail":"{read_only:false; response_revision:5085; number_of_response:1; }","duration":"3.231412779s","start":"2026-07-17T12:51:08.549981Z","end":"2026-07-17T12:51:11.781394Z","steps":["trace[489115703] 'process raft request' (duration: 3.231277585s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:11.781601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:08.550773Z","time spent":"3.230819892s","remote":"127.0.0.1:33736","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-07-17T12:51:11.781726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.231205293s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/local-path-storage/helper-pod-create-pvc-5993be03-02ce-4394-ae40-3f3c59ac0d63\" ","response":"range_response_count:1 size:2244"} {"level":"warn","ts":"2026-07-17T12:51:11.78178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:08.549974Z","time spent":"3.231700297s","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T12:51:11.781794Z","caller":"traceutil/trace.go:171","msg":"trace[598602612] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/local-path-storage/helper-pod-create-pvc-5993be03-02ce-4394-ae40-3f3c59ac0d63; range_end:; response_count:1; response_revision:5085; }","duration":"3.231296485s","start":"2026-07-17T12:51:08.55048Z","end":"2026-07-17T12:51:11.781776Z","steps":["trace[598602612] 'agreement among raft nodes before linearized reading' (duration: 3.23111401s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:11.78183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:08.550473Z","time spent":"3.231349927s","remote":"127.0.0.1:37936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":1,"response size":2268,"request content":"key:\"/registry/cilium.io/ciliumendpoints/local-path-storage/helper-pod-create-pvc-5993be03-02ce-4394-ae40-3f3c59ac0d63\" "} {"level":"info","ts":"2026-07-17T12:51:11.789074Z","caller":"traceutil/trace.go:171","msg":"trace[486340029] transaction","detail":"{read_only:false; response_revision:5088; number_of_response:1; }","duration":"2.165619425s","start":"2026-07-17T12:51:09.623443Z","end":"2026-07-17T12:51:11.789063Z","steps":["trace[486340029] 'process raft request' (duration: 2.165566694s)"],"step_count":1} {"level":"info","ts":"2026-07-17T12:51:11.789075Z","caller":"traceutil/trace.go:171","msg":"trace[1034609441] transaction","detail":"{read_only:false; response_revision:5086; number_of_response:1; }","duration":"3.235776231s","start":"2026-07-17T12:51:08.553282Z","end":"2026-07-17T12:51:11.789059Z","steps":["trace[1034609441] 'process raft request' (duration: 3.235603177s)"],"step_count":1} {"level":"info","ts":"2026-07-17T12:51:11.789097Z","caller":"traceutil/trace.go:171","msg":"trace[1514246292] transaction","detail":"{read_only:false; response_revision:5087; number_of_response:1; }","duration":"2.167319283s","start":"2026-07-17T12:51:09.621763Z","end":"2026-07-17T12:51:11.789083Z","steps":["trace[1514246292] 'process raft request' (duration: 2.16721023s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:11.789179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:09.621745Z","time spent":"2.167386225s","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T12:51:11.78918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:08.553269Z","time spent":"3.235850874s","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T12:51:11.789216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:09.623431Z","time spent":"2.165680237s","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T12:51:11.789362Z","caller":"traceutil/trace.go:171","msg":"trace[271987957] transaction","detail":"{read_only:false; response_revision:5089; number_of_response:1; }","duration":"2.097719839s","start":"2026-07-17T12:51:09.691608Z","end":"2026-07-17T12:51:11.789328Z","steps":["trace[271987957] 'process raft request' (duration: 2.097426551s)"],"step_count":1} {"level":"info","ts":"2026-07-17T12:51:11.789386Z","caller":"traceutil/trace.go:171","msg":"trace[1667337100] transaction","detail":"{read_only:false; response_revision:5090; number_of_response:1; }","duration":"2.005477558s","start":"2026-07-17T12:51:09.783889Z","end":"2026-07-17T12:51:11.789367Z","steps":["trace[1667337100] 'process raft request' (duration: 2.005342314s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:11.789463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:09.783874Z","time spent":"2.00555516s","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T12:51:11.789512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:09.691587Z","time spent":"2.097842963s","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T12:51:11.789681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.599964195s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T12:51:11.789722Z","caller":"traceutil/trace.go:171","msg":"trace[1432125025] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:5091; }","duration":"1.600027886s","start":"2026-07-17T12:51:10.189684Z","end":"2026-07-17T12:51:11.789712Z","steps":["trace[1432125025] 'agreement among raft nodes before linearized reading' (duration: 1.599963444s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:11.789729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.877067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-17T12:51:11.789754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:10.189665Z","time spent":"1.600082288s","remote":"127.0.0.1:34040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":29,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"info","ts":"2026-07-17T12:51:11.789765Z","caller":"traceutil/trace.go:171","msg":"trace[798652673] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5091; }","duration":"408.96166ms","start":"2026-07-17T12:51:11.380793Z","end":"2026-07-17T12:51:11.789755Z","steps":["trace[798652673] 'agreement among raft nodes before linearized reading' (duration: 408.901718ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T12:51:11.789666Z","caller":"traceutil/trace.go:171","msg":"trace[258199511] transaction","detail":"{read_only:false; response_revision:5091; number_of_response:1; }","duration":"1.238380852s","start":"2026-07-17T12:51:10.551233Z","end":"2026-07-17T12:51:11.789614Z","steps":["trace[258199511] 'process raft request' (duration: 1.238081924s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:11.789805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.099654084s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-07-17T12:51:11.789847Z","caller":"traceutil/trace.go:171","msg":"trace[2017175200] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5091; }","duration":"2.099728925s","start":"2026-07-17T12:51:09.690108Z","end":"2026-07-17T12:51:11.789837Z","steps":["trace[2017175200] 'agreement among raft nodes before linearized reading' (duration: 2.099632073s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:11.789878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:09.690088Z","time spent":"2.099783257s","remote":"127.0.0.1:33816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12236,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-07-17T12:51:11.789914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"701.32047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-17T12:51:11.789948Z","caller":"traceutil/trace.go:171","msg":"trace[187938352] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:5091; }","duration":"701.386522ms","start":"2026-07-17T12:51:11.088552Z","end":"2026-07-17T12:51:11.789938Z","steps":["trace[187938352] 'agreement among raft nodes before linearized reading' (duration: 701.332031ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:11.789976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:11.088534Z","time spent":"701.436054ms","remote":"127.0.0.1:34130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":4,"response size":31,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-07-17T12:51:11.790023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.854081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-17T12:51:11.79006Z","caller":"traceutil/trace.go:171","msg":"trace[400728887] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:5091; }","duration":"310.929643ms","start":"2026-07-17T12:51:11.479121Z","end":"2026-07-17T12:51:11.790051Z","steps":["trace[400728887] 'agreement among raft nodes before linearized reading' (duration: 310.82234ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:11.790064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.144618112s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-17T12:51:11.790093Z","caller":"traceutil/trace.go:171","msg":"trace[1129948361] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5091; }","duration":"2.144679984s","start":"2026-07-17T12:51:09.645405Z","end":"2026-07-17T12:51:11.790085Z","steps":["trace[1129948361] 'agreement among raft nodes before linearized reading' (duration: 2.144604702s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:11.790124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:09.645383Z","time spent":"2.144735676s","remote":"127.0.0.1:33904","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":"warn","ts":"2026-07-17T12:51:11.790144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.235037921s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-07-17T12:51:11.790174Z","caller":"traceutil/trace.go:171","msg":"trace[890593455] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:5091; }","duration":"3.235079512s","start":"2026-07-17T12:51:08.555088Z","end":"2026-07-17T12:51:11.790167Z","steps":["trace[890593455] 'agreement among raft nodes before linearized reading' (duration: 3.23502578s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:11.790201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:08.555074Z","time spent":"3.235121663s","remote":"127.0.0.1:33796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":445,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"warn","ts":"2026-07-17T12:51:11.790239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.238498988s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8z2pt\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-07-17T12:51:11.790264Z","caller":"traceutil/trace.go:171","msg":"trace[1745013555] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8z2pt; range_end:; response_count:1; response_revision:5091; }","duration":"3.238533149s","start":"2026-07-17T12:51:08.551725Z","end":"2026-07-17T12:51:11.790258Z","steps":["trace[1745013555] 'agreement among raft nodes before linearized reading' (duration: 3.238459667s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:11.789717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.238577861s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-07-17T12:51:11.790093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:11.479101Z","time spent":"310.984825ms","remote":"127.0.0.1:33754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":54,"response size":31,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"info","ts":"2026-07-17T12:51:11.790324Z","caller":"traceutil/trace.go:171","msg":"trace[705628353] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5091; }","duration":"3.239191098s","start":"2026-07-17T12:51:08.551117Z","end":"2026-07-17T12:51:11.790308Z","steps":["trace[705628353] 'agreement among raft nodes before linearized reading' (duration: 3.238489478s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:11.790369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:08.55111Z","time spent":"3.23924469s","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-17T12:51:11.7904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.148925961s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5993be03-02ce-4394-ae40-3f3c59ac0d63\" ","response":"range_response_count:1 size:3893"} {"level":"warn","ts":"2026-07-17T12:51:11.78979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:11.380756Z","time spent":"409.029202ms","remote":"127.0.0.1:33658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-17T12:51:11.790435Z","caller":"traceutil/trace.go:171","msg":"trace[1782626201] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5993be03-02ce-4394-ae40-3f3c59ac0d63; range_end:; response_count:1; response_revision:5091; }","duration":"3.148990133s","start":"2026-07-17T12:51:08.641434Z","end":"2026-07-17T12:51:11.790424Z","steps":["trace[1782626201] 'agreement among raft nodes before linearized reading' (duration: 3.14889308s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:11.790458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:08.641413Z","time spent":"3.149039974s","remote":"127.0.0.1:33816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3917,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5993be03-02ce-4394-ae40-3f3c59ac0d63\" "} {"level":"warn","ts":"2026-07-17T12:51:11.790491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.229166246s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5993be03-02ce-4394-ae40-3f3c59ac0d63\" ","response":"range_response_count:1 size:3893"} {"level":"info","ts":"2026-07-17T12:51:11.79052Z","caller":"traceutil/trace.go:171","msg":"trace[2032379906] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5993be03-02ce-4394-ae40-3f3c59ac0d63; range_end:; response_count:1; response_revision:5091; }","duration":"3.229208346s","start":"2026-07-17T12:51:08.561304Z","end":"2026-07-17T12:51:11.790512Z","steps":["trace[2032379906] 'agreement among raft nodes before linearized reading' (duration: 3.229145494s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:11.790286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:08.551719Z","time spent":"3.2385635s","remote":"127.0.0.1:33816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6544,"request content":"key:\"/registry/pods/openstack/keepalived-8z2pt\" "} {"level":"warn","ts":"2026-07-17T12:51:11.790544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:08.561293Z","time spent":"3.229246407s","remote":"127.0.0.1:33816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3917,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5993be03-02ce-4394-ae40-3f3c59ac0d63\" "} {"level":"warn","ts":"2026-07-17T12:51:11.790425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.534882118s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:786853"} {"level":"info","ts":"2026-07-17T12:51:11.790639Z","caller":"traceutil/trace.go:171","msg":"trace[71390074] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5091; }","duration":"1.535083983s","start":"2026-07-17T12:51:10.255536Z","end":"2026-07-17T12:51:11.79062Z","steps":["trace[71390074] 'agreement among raft nodes before linearized reading' (duration: 1.534548538s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:11.790667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:10.255518Z","time spent":"1.535139215s","remote":"127.0.0.1:33754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":25,"response size":786877,"request content":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" "} {"level":"warn","ts":"2026-07-17T12:51:11.791156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:10.551203Z","time spent":"1.238622119s","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T12:51:42.701929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.844464ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-17T12:51:42.702175Z","caller":"traceutil/trace.go:171","msg":"trace[741447911] transaction","detail":"{read_only:false; response_revision:5641; number_of_response:1; }","duration":"136.164301ms","start":"2026-07-17T12:51:42.565985Z","end":"2026-07-17T12:51:42.702149Z","steps":["trace[741447911] 'process raft request' (duration: 11.973138ms)","trace[741447911] 'compare' (duration: 123.685449ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T12:51:42.702334Z","caller":"traceutil/trace.go:171","msg":"trace[398648839] transaction","detail":"{read_only:false; response_revision:5642; number_of_response:1; }","duration":"135.846602ms","start":"2026-07-17T12:51:42.566467Z","end":"2026-07-17T12:51:42.702313Z","steps":["trace[398648839] 'process raft request' (duration: 135.609035ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T12:51:42.702495Z","caller":"traceutil/trace.go:171","msg":"trace[476301640] transaction","detail":"{read_only:false; response_revision:5643; number_of_response:1; }","duration":"135.918624ms","start":"2026-07-17T12:51:42.566563Z","end":"2026-07-17T12:51:42.702481Z","steps":["trace[476301640] 'process raft request' (duration: 135.684797ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T12:51:42.702498Z","caller":"traceutil/trace.go:171","msg":"trace[9225802] transaction","detail":"{read_only:false; response_revision:5644; number_of_response:1; }","duration":"135.828962ms","start":"2026-07-17T12:51:42.566646Z","end":"2026-07-17T12:51:42.702475Z","steps":["trace[9225802] 'process raft request' (duration: 135.750729ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T12:51:54.036267Z","caller":"traceutil/trace.go:171","msg":"trace[686289874] transaction","detail":"{read_only:false; response_revision:5718; number_of_response:1; }","duration":"108.417369ms","start":"2026-07-17T12:51:53.927823Z","end":"2026-07-17T12:51:54.036241Z","steps":["trace[686289874] 'process raft request' (duration: 108.273695ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T12:51:54.039405Z","caller":"traceutil/trace.go:171","msg":"trace[1424670051] transaction","detail":"{read_only:false; response_revision:5720; number_of_response:1; }","duration":"106.624978ms","start":"2026-07-17T12:51:53.932769Z","end":"2026-07-17T12:51:54.039394Z","steps":["trace[1424670051] 'process raft request' (duration: 106.559646ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T12:51:54.039453Z","caller":"traceutil/trace.go:171","msg":"trace[126368299] transaction","detail":"{read_only:false; response_revision:5719; number_of_response:1; }","duration":"107.76421ms","start":"2026-07-17T12:51:53.931663Z","end":"2026-07-17T12:51:54.039427Z","steps":["trace[126368299] 'process raft request' (duration: 107.603906ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T12:51:54.039584Z","caller":"traceutil/trace.go:171","msg":"trace[1270840579] transaction","detail":"{read_only:false; response_revision:5721; number_of_response:1; }","duration":"105.312001ms","start":"2026-07-17T12:51:53.934262Z","end":"2026-07-17T12:51:54.039574Z","steps":["trace[1270840579] 'process raft request' (duration: 105.110536ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:51:56.707906Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6277067284459442556,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-17T12:52:00.353758Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6277067284459442556,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-17T12:52:00.359913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.142216764s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-17T12:52:00.360009Z","caller":"traceutil/trace.go:171","msg":"trace[2078015089] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"4.142342418s","start":"2026-07-17T12:51:56.217644Z","end":"2026-07-17T12:52:00.359987Z","steps":["trace[2078015089] 'agreement among raft nodes before linearized reading' (duration: 4.142234075s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:52:00.360047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:56.217631Z","time spent":"4.142407689s","remote":"127.0.0.1:33658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/07/17 12:52:00 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-17T12:52:00.799296Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"4.75783967s","expected-duration":"1s"} {"level":"info","ts":"2026-07-17T12:52:00.799682Z","caller":"traceutil/trace.go:171","msg":"trace[1749664941] transaction","detail":"{read_only:false; response_revision:5727; number_of_response:1; }","duration":"4.758351174s","start":"2026-07-17T12:51:56.041306Z","end":"2026-07-17T12:52:00.799657Z","steps":["trace[1749664941] 'process raft request' (duration: 4.758176649s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:52:00.799811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:56.041267Z","time spent":"4.758479958s","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T12:52:00.802107Z","caller":"traceutil/trace.go:171","msg":"trace[244056418] transaction","detail":"{read_only:false; response_revision:5728; number_of_response:1; }","duration":"4.59409912s","start":"2026-07-17T12:51:56.207966Z","end":"2026-07-17T12:52:00.802065Z","steps":["trace[244056418] 'process raft request' (duration: 4.593905865s)"],"step_count":1} {"level":"info","ts":"2026-07-17T12:52:00.802374Z","caller":"traceutil/trace.go:171","msg":"trace[507618385] transaction","detail":"{read_only:false; response_revision:5730; number_of_response:1; }","duration":"4.593653538s","start":"2026-07-17T12:51:56.208703Z","end":"2026-07-17T12:52:00.802356Z","steps":["trace[507618385] 'process raft request' (duration: 4.593295497s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:52:00.802493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:56.208659Z","time spent":"4.593778561s","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T12:52:00.80238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:56.207948Z","time spent":"4.594280375s","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T12:52:00.802638Z","caller":"traceutil/trace.go:171","msg":"trace[915500471] transaction","detail":"{read_only:false; response_revision:5731; number_of_response:1; }","duration":"439.877548ms","start":"2026-07-17T12:52:00.362731Z","end":"2026-07-17T12:52:00.802608Z","steps":["trace[915500471] 'process raft request' (duration: 439.562209ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T12:52:00.802201Z","caller":"traceutil/trace.go:171","msg":"trace[1937919813] transaction","detail":"{read_only:false; response_revision:5729; number_of_response:1; }","duration":"4.593465302s","start":"2026-07-17T12:51:56.208707Z","end":"2026-07-17T12:52:00.802172Z","steps":["trace[1937919813] 'process raft request' (duration: 4.593254206s)"],"step_count":1} {"level":"info","ts":"2026-07-17T12:52:00.802803Z","caller":"traceutil/trace.go:171","msg":"trace[204273253] linearizableReadLoop","detail":"{readStateIndex:5937; appliedIndex:5934; }","duration":"4.595042437s","start":"2026-07-17T12:51:56.207749Z","end":"2026-07-17T12:52:00.802792Z","steps":["trace[204273253] 'read index received' (duration: 4.591895638s)","trace[204273253] 'applied index is now lower than readState.Index' (duration: 3.145909ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T12:52:00.802813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:52:00.362719Z","time spent":"440.005621ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T12:52:00.80288Z","caller":"traceutil/trace.go:171","msg":"trace[799625900] transaction","detail":"{read_only:false; response_revision:5732; number_of_response:1; }","duration":"435.328989ms","start":"2026-07-17T12:52:00.367533Z","end":"2026-07-17T12:52:00.802862Z","steps":["trace[799625900] 'process raft request' (duration: 434.987639ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:52:00.802964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.482261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-17T12:52:00.802979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.594145992s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-17T12:52:00.803007Z","caller":"traceutil/trace.go:171","msg":"trace[1304671812] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5732; }","duration":"4.594187173s","start":"2026-07-17T12:51:56.208814Z","end":"2026-07-17T12:52:00.803001Z","steps":["trace[1304671812] 'agreement among raft nodes before linearized reading' (duration: 4.594061199s)"],"step_count":1} {"level":"info","ts":"2026-07-17T12:52:00.803008Z","caller":"traceutil/trace.go:171","msg":"trace[1685284244] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5732; }","duration":"442.546613ms","start":"2026-07-17T12:52:00.360451Z","end":"2026-07-17T12:52:00.802997Z","steps":["trace[1685284244] 'agreement among raft nodes before linearized reading' (duration: 442.481191ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:52:00.803033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:56.208809Z","time spent":"4.594217944s","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-17T12:52:00.80297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:52:00.367513Z","time spent":"435.421142ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T12:52:00.803126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.692397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T12:52:00.803161Z","caller":"traceutil/trace.go:171","msg":"trace[1563902142] range","detail":"{range_begin:/registry/monitoring.coreos.com/scrapeconfigs/; range_end:/registry/monitoring.coreos.com/scrapeconfigs0; response_count:0; response_revision:5732; }","duration":"442.753889ms","start":"2026-07-17T12:52:00.360398Z","end":"2026-07-17T12:52:00.803152Z","steps":["trace[1563902142] 'agreement among raft nodes before linearized reading' (duration: 442.699958ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:52:00.803192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:52:00.360382Z","time spent":"442.80276ms","remote":"127.0.0.1:34958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true "} {"level":"warn","ts":"2026-07-17T12:52:00.803037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:52:00.360437Z","time spent":"442.594444ms","remote":"127.0.0.1:33646","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-07-17T12:52:00.803379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.322391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:413472"} {"level":"info","ts":"2026-07-17T12:52:00.803423Z","caller":"traceutil/trace.go:171","msg":"trace[1291215323] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:5732; }","duration":"359.384543ms","start":"2026-07-17T12:52:00.444019Z","end":"2026-07-17T12:52:00.803404Z","steps":["trace[1291215323] 'agreement among raft nodes before linearized reading' (duration: 359.125726ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:52:00.803454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:52:00.444001Z","time spent":"359.446785ms","remote":"127.0.0.1:55152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":413496,"request content":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" "} {"level":"warn","ts":"2026-07-17T12:52:00.803373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.595583012s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8z2pt\" ","response":"range_response_count:1 size:6520"} {"level":"warn","ts":"2026-07-17T12:52:00.803565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.4930533s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-07-17T12:52:00.803603Z","caller":"traceutil/trace.go:171","msg":"trace[972116782] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5732; }","duration":"4.493110291s","start":"2026-07-17T12:51:56.310482Z","end":"2026-07-17T12:52:00.803593Z","steps":["trace[972116782] 'agreement among raft nodes before linearized reading' (duration: 4.493037608s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:52:00.803626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:56.31047Z","time spent":"4.493150512s","remote":"127.0.0.1:33792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1889,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-07-17T12:52:00.803727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.821103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T12:52:00.803767Z","caller":"traceutil/trace.go:171","msg":"trace[912285224] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5732; }","duration":"435.878454ms","start":"2026-07-17T12:52:00.36788Z","end":"2026-07-17T12:52:00.803758Z","steps":["trace[912285224] 'agreement among raft nodes before linearized reading' (duration: 435.814282ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:52:00.803794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:52:00.367864Z","time spent":"435.925186ms","remote":"127.0.0.1:33658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-17T12:52:00.803763Z","caller":"traceutil/trace.go:171","msg":"trace[412494100] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8z2pt; range_end:; response_count:1; response_revision:5732; }","duration":"4.59587087s","start":"2026-07-17T12:51:56.20771Z","end":"2026-07-17T12:52:00.803581Z","steps":["trace[412494100] 'agreement among raft nodes before linearized reading' (duration: 4.59514122s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:52:00.803811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.594947835s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-07-17T12:52:00.803841Z","caller":"traceutil/trace.go:171","msg":"trace[1231073268] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5732; }","duration":"4.594983995s","start":"2026-07-17T12:51:56.208849Z","end":"2026-07-17T12:52:00.803833Z","steps":["trace[1231073268] 'agreement among raft nodes before linearized reading' (duration: 4.594911903s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:52:00.803875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:56.208843Z","time spent":"4.595024986s","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-17T12:52:00.803944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.595046577s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-17T12:52:00.803125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.457968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-17T12:52:00.804032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.41548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-07-17T12:52:00.804021Z","caller":"traceutil/trace.go:171","msg":"trace[450508103] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5732; }","duration":"4.59516092s","start":"2026-07-17T12:51:56.208849Z","end":"2026-07-17T12:52:00.80401Z","steps":["trace[450508103] 'agreement among raft nodes before linearized reading' (duration: 4.594869852s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:52:00.803416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.128669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-07-17T12:52:00.804119Z","caller":"traceutil/trace.go:171","msg":"trace[1450874813] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5732; }","duration":"443.85079ms","start":"2026-07-17T12:52:00.360254Z","end":"2026-07-17T12:52:00.804104Z","steps":["trace[1450874813] 'agreement among raft nodes before linearized reading' (duration: 443.080908ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:52:00.804156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:52:00.360242Z","time spent":"443.905951ms","remote":"127.0.0.1:53252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3340,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"warn","ts":"2026-07-17T12:52:00.804185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.876742ms","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-07-17T12:52:00.804224Z","caller":"traceutil/trace.go:171","msg":"trace[1325127584] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5732; }","duration":"442.933784ms","start":"2026-07-17T12:52:00.361275Z","end":"2026-07-17T12:52:00.804209Z","steps":["trace[1325127584] 'agreement among raft nodes before linearized reading' (duration: 442.80817ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:52:00.804263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:52:00.361262Z","time spent":"442.996585ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":553,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"warn","ts":"2026-07-17T12:52:00.804327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.595431148s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-07-17T12:52:00.804331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.629664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T12:52:00.804366Z","caller":"traceutil/trace.go:171","msg":"trace[1485862121] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5732; }","duration":"4.59549853s","start":"2026-07-17T12:51:56.20886Z","end":"2026-07-17T12:52:00.804358Z","steps":["trace[1485862121] 'agreement among raft nodes before linearized reading' (duration: 4.595409898s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:52:00.804399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:56.208849Z","time spent":"4.595543561s","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-17T12:52:00.804398Z","caller":"traceutil/trace.go:171","msg":"trace[1426535378] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:5732; }","duration":"443.730696ms","start":"2026-07-17T12:52:00.360631Z","end":"2026-07-17T12:52:00.804362Z","steps":["trace[1426535378] 'agreement among raft nodes before linearized reading' (duration: 443.620193ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:52:00.804441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:52:00.360623Z","time spent":"443.809798ms","remote":"127.0.0.1:55184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-17T12:52:00.803922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:56.208694Z","time spent":"4.594054329s","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T12:52:00.803498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.115479316s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.52\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-07-17T12:52:00.803862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:56.207691Z","time spent":"4.596152539s","remote":"127.0.0.1:33816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6544,"request content":"key:\"/registry/pods/openstack/keepalived-8z2pt\" "} {"level":"info","ts":"2026-07-17T12:52:00.804698Z","caller":"traceutil/trace.go:171","msg":"trace[1388830745] range","detail":"{range_begin:/registry/masterleases/199.19.213.52; range_end:; response_count:1; response_revision:5732; }","duration":"4.116753962s","start":"2026-07-17T12:51:56.68793Z","end":"2026-07-17T12:52:00.804684Z","steps":["trace[1388830745] 'agreement among raft nodes before linearized reading' (duration: 4.115512667s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:52:00.804751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:56.687909Z","time spent":"4.116827704s","remote":"127.0.0.1:33700","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.19.213.52\" "} {"level":"info","ts":"2026-07-17T12:52:00.804052Z","caller":"traceutil/trace.go:171","msg":"trace[1838518543] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:5732; }","duration":"107.424755ms","start":"2026-07-17T12:52:00.696615Z","end":"2026-07-17T12:52:00.80404Z","steps":["trace[1838518543] 'agreement among raft nodes before linearized reading' (duration: 106.456198ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:52:00.804454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.932782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T12:52:00.804931Z","caller":"traceutil/trace.go:171","msg":"trace[1884258602] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:5732; }","duration":"444.412145ms","start":"2026-07-17T12:52:00.360508Z","end":"2026-07-17T12:52:00.80492Z","steps":["trace[1884258602] 'agreement among raft nodes before linearized reading' (duration: 443.922611ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:52:00.804989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:52:00.360506Z","time spent":"444.470297ms","remote":"127.0.0.1:59882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true "} {"level":"warn","ts":"2026-07-17T12:52:00.804339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.593333758s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10886"} {"level":"info","ts":"2026-07-17T12:52:00.805094Z","caller":"traceutil/trace.go:171","msg":"trace[1449483790] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5732; }","duration":"4.59409657s","start":"2026-07-17T12:51:56.210973Z","end":"2026-07-17T12:52:00.80507Z","steps":["trace[1449483790] 'agreement among raft nodes before linearized reading' (duration: 4.593242996s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:52:00.805156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:56.21096Z","time spent":"4.594180182s","remote":"127.0.0.1:33816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":10910,"request content":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-07-17T12:52:00.804134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:56.208833Z","time spent":"4.595292164s","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-17T12:52:00.804059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.551701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T12:52:00.805432Z","caller":"traceutil/trace.go:171","msg":"trace[334927639] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:5732; }","duration":"444.93058ms","start":"2026-07-17T12:52:00.360487Z","end":"2026-07-17T12:52:00.805418Z","steps":["trace[334927639] 'agreement among raft nodes before linearized reading' (duration: 443.52163ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:52:00.805483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:52:00.360482Z","time spent":"444.988112ms","remote":"127.0.0.1:55158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"info","ts":"2026-07-17T12:52:00.80407Z","caller":"traceutil/trace.go:171","msg":"trace[531411594] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5732; }","duration":"436.468881ms","start":"2026-07-17T12:52:00.367588Z","end":"2026-07-17T12:52:00.804057Z","steps":["trace[531411594] 'agreement among raft nodes before linearized reading' (duration: 436.331107ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:52:00.80559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:52:00.367582Z","time spent":"437.991815ms","remote":"127.0.0.1:33816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12236,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-07-17T12:52:00.804523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.595618684s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-17T12:52:00.805682Z","caller":"traceutil/trace.go:171","msg":"trace[982636260] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5732; }","duration":"4.596777206s","start":"2026-07-17T12:51:56.208892Z","end":"2026-07-17T12:52:00.805669Z","steps":["trace[982636260] 'agreement among raft nodes before linearized reading' (duration: 4.595589513s)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:52:00.805761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T12:51:56.208886Z","time spent":"4.596861258s","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-17T12:52:23.551641Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2966} {"level":"info","ts":"2026-07-17T12:52:23.617627Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2966,"took":"64.84731ms","hash":1531825022,"current-db-size-bytes":57769984,"current-db-size":"58 MB","current-db-size-in-use-bytes":33390592,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-07-17T12:52:23.617703Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1531825022,"revision":2966,"compact-revision":-1} {"level":"info","ts":"2026-07-17T12:52:29.052585Z","caller":"traceutil/trace.go:171","msg":"trace[2120371556] transaction","detail":"{read_only:false; response_revision:6003; number_of_response:1; }","duration":"111.103265ms","start":"2026-07-17T12:52:28.94145Z","end":"2026-07-17T12:52:29.052554Z","steps":["trace[2120371556] 'process raft request' (duration: 110.91585ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T12:57:23.557336Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5973} {"level":"info","ts":"2026-07-17T12:57:23.647721Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5973,"took":"88.975842ms","hash":2175523941,"current-db-size-bytes":57769984,"current-db-size":"58 MB","current-db-size-in-use-bytes":25423872,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-07-17T12:57:23.647807Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2175523941,"revision":5973,"compact-revision":2966} {"level":"info","ts":"2026-07-17T12:57:46.774189Z","caller":"traceutil/trace.go:171","msg":"trace[187175258] linearizableReadLoop","detail":"{readStateIndex:8635; appliedIndex:8634; }","duration":"130.468329ms","start":"2026-07-17T12:57:46.643695Z","end":"2026-07-17T12:57:46.774163Z","steps":["trace[187175258] 'read index received' (duration: 130.331695ms)","trace[187175258] 'applied index is now lower than readState.Index' (duration: 135.544µs)"],"step_count":2} {"level":"info","ts":"2026-07-17T12:57:46.774361Z","caller":"traceutil/trace.go:171","msg":"trace[1079440347] transaction","detail":"{read_only:false; response_revision:8342; number_of_response:1; }","duration":"178.838085ms","start":"2026-07-17T12:57:46.595392Z","end":"2026-07-17T12:57:46.77423Z","steps":["trace[1079440347] 'process raft request' (duration: 178.628459ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:57:46.774554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.447846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-17T12:57:46.77453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.657391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-17T12:57:46.7746Z","caller":"traceutil/trace.go:171","msg":"trace[1780497913] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8342; }","duration":"121.506848ms","start":"2026-07-17T12:57:46.653077Z","end":"2026-07-17T12:57:46.774584Z","steps":["trace[1780497913] 'agreement among raft nodes before linearized reading' (duration: 121.423595ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:57:46.774457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.738286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-07-17T12:57:46.774618Z","caller":"traceutil/trace.go:171","msg":"trace[295994142] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8342; }","duration":"121.798655ms","start":"2026-07-17T12:57:46.652798Z","end":"2026-07-17T12:57:46.774597Z","steps":["trace[295994142] 'agreement among raft nodes before linearized reading' (duration: 121.550218ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T12:57:46.77472Z","caller":"traceutil/trace.go:171","msg":"trace[676436709] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8342; }","duration":"131.004254ms","start":"2026-07-17T12:57:46.643663Z","end":"2026-07-17T12:57:46.774667Z","steps":["trace[676436709] 'agreement among raft nodes before linearized reading' (duration: 130.643574ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:57:46.774744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.599629ms","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-07-17T12:57:46.774901Z","caller":"traceutil/trace.go:171","msg":"trace[460000687] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8342; }","duration":"121.775125ms","start":"2026-07-17T12:57:46.653103Z","end":"2026-07-17T12:57:46.774878Z","steps":["trace[460000687] 'agreement among raft nodes before linearized reading' (duration: 121.279751ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T12:57:46.958471Z","caller":"traceutil/trace.go:171","msg":"trace[182445103] transaction","detail":"{read_only:false; response_revision:8347; number_of_response:1; }","duration":"178.773353ms","start":"2026-07-17T12:57:46.779652Z","end":"2026-07-17T12:57:46.958425Z","steps":["trace[182445103] 'process raft request' (duration: 140.186351ms)","trace[182445103] 'compare' (duration: 38.362686ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T12:58:00.291671Z","caller":"traceutil/trace.go:171","msg":"trace[663316591] transaction","detail":"{read_only:false; response_revision:8412; number_of_response:1; }","duration":"137.600479ms","start":"2026-07-17T12:58:00.154038Z","end":"2026-07-17T12:58:00.291639Z","steps":["trace[663316591] 'process raft request' (duration: 123.273017ms)","trace[663316591] 'compare' (duration: 14.162747ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T12:58:00.291948Z","caller":"traceutil/trace.go:171","msg":"trace[535397738] transaction","detail":"{read_only:false; response_revision:8413; number_of_response:1; }","duration":"133.704639ms","start":"2026-07-17T12:58:00.158229Z","end":"2026-07-17T12:58:00.291934Z","steps":["trace[535397738] 'process raft request' (duration: 133.358869ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T12:58:00.291921Z","caller":"traceutil/trace.go:171","msg":"trace[2019451767] transaction","detail":"{read_only:false; response_revision:8414; number_of_response:1; }","duration":"127.705021ms","start":"2026-07-17T12:58:00.164193Z","end":"2026-07-17T12:58:00.291899Z","steps":["trace[2019451767] 'process raft request' (duration: 127.600978ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T12:58:00.706118Z","caller":"traceutil/trace.go:171","msg":"trace[1290843573] transaction","detail":"{read_only:false; response_revision:8415; number_of_response:1; }","duration":"113.970406ms","start":"2026-07-17T12:58:00.592123Z","end":"2026-07-17T12:58:00.706094Z","steps":["trace[1290843573] 'process raft request' (duration: 113.839842ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:58:27.374166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.653066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T12:58:27.374326Z","caller":"traceutil/trace.go:171","msg":"trace[969487479] range","detail":"{range_begin:/registry/monitoring.coreos.com/scrapeconfigs/; range_end:/registry/monitoring.coreos.com/scrapeconfigs0; response_count:0; response_revision:8616; }","duration":"190.875592ms","start":"2026-07-17T12:58:27.183419Z","end":"2026-07-17T12:58:27.374294Z","steps":["trace[969487479] 'count revisions from in-memory index tree' (duration: 190.560274ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T12:58:27.374832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.008921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8z2pt\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-07-17T12:58:27.374886Z","caller":"traceutil/trace.go:171","msg":"trace[220034793] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8z2pt; range_end:; response_count:1; response_revision:8616; }","duration":"163.106874ms","start":"2026-07-17T12:58:27.211762Z","end":"2026-07-17T12:58:27.374869Z","steps":["trace[220034793] 'range keys from in-memory index tree' (duration: 162.760234ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T12:58:41.293561Z","caller":"traceutil/trace.go:171","msg":"trace[1437850662] transaction","detail":"{read_only:false; response_revision:8738; number_of_response:1; }","duration":"121.825176ms","start":"2026-07-17T12:58:41.171707Z","end":"2026-07-17T12:58:41.293533Z","steps":["trace[1437850662] 'process raft request' (duration: 121.721853ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T12:58:56.500442Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023e2.wal"} {"level":"info","ts":"2026-07-17T13:00:21.720157Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e1254347e028571c","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-17T13:00:21.727899Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-07-17T13:00:21.728037Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-07-17T13:02:23.564841Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8041} {"level":"info","ts":"2026-07-17T13:02:23.624497Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8041,"took":"57.376169ms","hash":2203261946,"current-db-size-bytes":57769984,"current-db-size":"58 MB","current-db-size-in-use-bytes":29212672,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-07-17T13:02:23.624567Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2203261946,"revision":8041,"compact-revision":5973} {"level":"info","ts":"2026-07-17T13:03:23.03661Z","caller":"traceutil/trace.go:171","msg":"trace[166774950] transaction","detail":"{read_only:false; response_revision:11229; number_of_response:1; }","duration":"193.092305ms","start":"2026-07-17T13:03:22.843443Z","end":"2026-07-17T13:03:23.036535Z","steps":["trace[166774950] 'process raft request' (duration: 122.024882ms)","trace[166774950] 'compare' (duration: 70.806476ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T13:03:44.807903Z","caller":"traceutil/trace.go:171","msg":"trace[1251650349] linearizableReadLoop","detail":"{readStateIndex:11734; appliedIndex:11733; }","duration":"119.09814ms","start":"2026-07-17T13:03:44.68878Z","end":"2026-07-17T13:03:44.807878Z","steps":["trace[1251650349] 'read index received' (duration: 118.805912ms)","trace[1251650349] 'applied index is now lower than readState.Index' (duration: 291.128µs)"],"step_count":2} {"level":"info","ts":"2026-07-17T13:03:44.808024Z","caller":"traceutil/trace.go:171","msg":"trace[1514885530] transaction","detail":"{read_only:false; response_revision:11347; number_of_response:1; }","duration":"130.699075ms","start":"2026-07-17T13:03:44.677237Z","end":"2026-07-17T13:03:44.807936Z","steps":["trace[1514885530] 'process raft request' (duration: 130.451219ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:03:44.808242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.45294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-17T13:03:44.808322Z","caller":"traceutil/trace.go:171","msg":"trace[363594589] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:11347; }","duration":"119.592934ms","start":"2026-07-17T13:03:44.688709Z","end":"2026-07-17T13:03:44.808302Z","steps":["trace[363594589] 'agreement among raft nodes before linearized reading' (duration: 119.346347ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:07:23.572456Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10604} {"level":"info","ts":"2026-07-17T13:07:23.655047Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10604,"took":"80.295174ms","hash":2031690360,"current-db-size-bytes":57769984,"current-db-size":"58 MB","current-db-size-in-use-bytes":27656192,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-07-17T13:07:23.655138Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2031690360,"revision":10604,"compact-revision":8041} {"level":"warn","ts":"2026-07-17T13:09:40.777742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.710735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:63 size:589774"} {"level":"info","ts":"2026-07-17T13:09:40.777839Z","caller":"traceutil/trace.go:171","msg":"trace[1698400928] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:63; response_revision:13803; }","duration":"134.839938ms","start":"2026-07-17T13:09:40.642981Z","end":"2026-07-17T13:09:40.777821Z","steps":["trace[1698400928] 'range keys from in-memory index tree' (duration: 134.078478ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:10:26.107699Z","caller":"traceutil/trace.go:171","msg":"trace[1843432744] transaction","detail":"{read_only:false; response_revision:14181; number_of_response:1; }","duration":"110.753885ms","start":"2026-07-17T13:10:25.996914Z","end":"2026-07-17T13:10:26.107668Z","steps":["trace[1843432744] 'process raft request' (duration: 110.55854ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:10:26.351799Z","caller":"traceutil/trace.go:171","msg":"trace[752065539] linearizableReadLoop","detail":"{readStateIndex:14665; appliedIndex:14664; }","duration":"124.233692ms","start":"2026-07-17T13:10:26.227533Z","end":"2026-07-17T13:10:26.351767Z","steps":["trace[752065539] 'read index received' (duration: 123.875152ms)","trace[752065539] 'applied index is now lower than readState.Index' (duration: 356.46µs)"],"step_count":2} {"level":"info","ts":"2026-07-17T13:10:26.35188Z","caller":"traceutil/trace.go:171","msg":"trace[561369169] transaction","detail":"{read_only:false; response_revision:14182; number_of_response:1; }","duration":"222.366555ms","start":"2026-07-17T13:10:26.129485Z","end":"2026-07-17T13:10:26.351851Z","steps":["trace[561369169] 'process raft request' (duration: 222.074067ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:10:26.352003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.434738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-17T13:10:26.352071Z","caller":"traceutil/trace.go:171","msg":"trace[424682817] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:14182; }","duration":"124.598213ms","start":"2026-07-17T13:10:26.227458Z","end":"2026-07-17T13:10:26.352056Z","steps":["trace[424682817] 'agreement among raft nodes before linearized reading' (duration: 124.440878ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:12:23.580187Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12796} {"level":"info","ts":"2026-07-17T13:12:23.671013Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12796,"took":"84.827139ms","hash":3192852416,"current-db-size-bytes":57769984,"current-db-size":"58 MB","current-db-size-in-use-bytes":31014912,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-17T13:12:23.6711Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3192852416,"revision":12796,"compact-revision":10604} {"level":"info","ts":"2026-07-17T13:17:23.588613Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15357} {"level":"info","ts":"2026-07-17T13:17:23.67964Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15357,"took":"87.141781ms","hash":2171320780,"current-db-size-bytes":57769984,"current-db-size":"58 MB","current-db-size-in-use-bytes":32440320,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-07-17T13:17:23.679732Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2171320780,"revision":15357,"compact-revision":12796} {"level":"info","ts":"2026-07-17T13:17:41.143161Z","caller":"traceutil/trace.go:171","msg":"trace[729542556] transaction","detail":"{read_only:false; response_revision:17757; number_of_response:1; }","duration":"122.622148ms","start":"2026-07-17T13:17:41.02051Z","end":"2026-07-17T13:17:41.143132Z","steps":["trace[729542556] 'process raft request' (duration: 121.96099ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:17:41.156911Z","caller":"traceutil/trace.go:171","msg":"trace[1300048335] transaction","detail":"{read_only:false; response_revision:17760; number_of_response:1; }","duration":"135.806142ms","start":"2026-07-17T13:17:41.021079Z","end":"2026-07-17T13:17:41.156885Z","steps":["trace[1300048335] 'process raft request' (duration: 135.72339ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:17:41.156916Z","caller":"traceutil/trace.go:171","msg":"trace[858066710] transaction","detail":"{read_only:false; response_revision:17759; number_of_response:1; }","duration":"136.232733ms","start":"2026-07-17T13:17:41.020661Z","end":"2026-07-17T13:17:41.156894Z","steps":["trace[858066710] 'process raft request' (duration: 136.10257ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:17:41.156977Z","caller":"traceutil/trace.go:171","msg":"trace[1085272677] transaction","detail":"{read_only:false; response_revision:17758; number_of_response:1; }","duration":"136.409268ms","start":"2026-07-17T13:17:41.020554Z","end":"2026-07-17T13:17:41.156963Z","steps":["trace[1085272677] 'process raft request' (duration: 136.081889ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:17:48.084036Z","caller":"traceutil/trace.go:171","msg":"trace[432979003] transaction","detail":"{read_only:false; response_revision:17880; number_of_response:1; }","duration":"100.622122ms","start":"2026-07-17T13:17:47.983384Z","end":"2026-07-17T13:17:48.084006Z","steps":["trace[432979003] 'process raft request' (duration: 100.402336ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:17:48.577406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.100029ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-17T13:17:48.577618Z","caller":"traceutil/trace.go:171","msg":"trace[1102910535] transaction","detail":"{read_only:false; response_revision:17882; number_of_response:1; }","duration":"483.054808ms","start":"2026-07-17T13:17:48.094523Z","end":"2026-07-17T13:17:48.577578Z","steps":["trace[1102910535] 'process raft request' (duration: 362.702772ms)","trace[1102910535] 'compare' (duration: 119.919404ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T13:17:48.57773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:17:48.094506Z","time spent":"483.170452ms","remote":"127.0.0.1:33796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":931,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T13:17:48.577889Z","caller":"traceutil/trace.go:171","msg":"trace[707155857] transaction","detail":"{read_only:false; response_revision:17883; number_of_response:1; }","duration":"482.769111ms","start":"2026-07-17T13:17:48.095084Z","end":"2026-07-17T13:17:48.577854Z","steps":["trace[707155857] 'process raft request' (duration: 482.409921ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:17:48.578075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:17:48.095071Z","time spent":"482.886464ms","remote":"127.0.0.1:33796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":877,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T13:17:48.578123Z","caller":"traceutil/trace.go:171","msg":"trace[1055370667] transaction","detail":"{read_only:false; response_revision:17884; number_of_response:1; }","duration":"482.37485ms","start":"2026-07-17T13:17:48.095713Z","end":"2026-07-17T13:17:48.578088Z","steps":["trace[1055370667] 'process raft request' (duration: 481.833275ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:17:48.57823Z","caller":"traceutil/trace.go:171","msg":"trace[1051558717] transaction","detail":"{read_only:false; response_revision:17885; number_of_response:1; }","duration":"469.69336ms","start":"2026-07-17T13:17:48.108527Z","end":"2026-07-17T13:17:48.578221Z","steps":["trace[1051558717] 'process raft request' (duration: 469.632488ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:17:48.578288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:17:48.108513Z","time spent":"469.748942ms","remote":"127.0.0.1:33816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20867,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T13:17:48.578318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:17:48.095703Z","time spent":"482.519524ms","remote":"127.0.0.1:33916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1474,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T13:20:49.678099Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e1254347e028571c","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-17T13:20:49.685194Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-07-17T13:20:49.685304Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-07-17T13:22:23.599717Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17639} {"level":"info","ts":"2026-07-17T13:22:23.708989Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17639,"took":"103.634706ms","hash":812926571,"current-db-size-bytes":57769984,"current-db-size":"58 MB","current-db-size-in-use-bytes":34668544,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-07-17T13:22:23.709072Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":812926571,"revision":17639,"compact-revision":15357} {"level":"info","ts":"2026-07-17T13:23:20.620242Z","caller":"traceutil/trace.go:171","msg":"trace[1326226763] linearizableReadLoop","detail":"{readStateIndex:21096; appliedIndex:21093; }","duration":"319.448829ms","start":"2026-07-17T13:23:20.300767Z","end":"2026-07-17T13:23:20.620216Z","steps":["trace[1326226763] 'read index received' (duration: 63.540112ms)","trace[1326226763] 'applied index is now lower than readState.Index' (duration: 255.907737ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T13:23:20.620377Z","caller":"traceutil/trace.go:171","msg":"trace[931429360] transaction","detail":"{read_only:false; response_revision:20414; number_of_response:1; }","duration":"319.626494ms","start":"2026-07-17T13:23:20.300716Z","end":"2026-07-17T13:23:20.620342Z","steps":["trace[931429360] 'process raft request' (duration: 319.456789ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:23:20.620371Z","caller":"traceutil/trace.go:171","msg":"trace[1853290226] transaction","detail":"{read_only:false; response_revision:20413; number_of_response:1; }","duration":"319.686145ms","start":"2026-07-17T13:23:20.30063Z","end":"2026-07-17T13:23:20.620316Z","steps":["trace[1853290226] 'process raft request' (duration: 319.393087ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:23:20.620436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.69268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-07-17T13:23:20.62046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.662125ms","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-07-17T13:23:20.620496Z","caller":"traceutil/trace.go:171","msg":"trace[1976023675] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:20414; }","duration":"219.777392ms","start":"2026-07-17T13:23:20.400704Z","end":"2026-07-17T13:23:20.620481Z","steps":["trace[1976023675] 'agreement among raft nodes before linearized reading' (duration: 219.656068ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:23:20.620527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:23:20.300697Z","time spent":"319.752137ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T13:23:20.620564Z","caller":"traceutil/trace.go:171","msg":"trace[165764816] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:20414; }","duration":"319.838689ms","start":"2026-07-17T13:23:20.300693Z","end":"2026-07-17T13:23:20.620532Z","steps":["trace[165764816] 'agreement among raft nodes before linearized reading' (duration: 319.665914ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:23:20.620565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:23:20.300599Z","time spent":"319.86175ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T13:23:20.620624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:23:20.30067Z","time spent":"319.942122ms","remote":"127.0.0.1:46584","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"info","ts":"2026-07-17T13:23:21.297806Z","caller":"traceutil/trace.go:171","msg":"trace[64566483] transaction","detail":"{read_only:false; response_revision:20416; number_of_response:1; }","duration":"239.050057ms","start":"2026-07-17T13:23:21.05872Z","end":"2026-07-17T13:23:21.29777Z","steps":["trace[64566483] 'process raft request' (duration: 151.000517ms)","trace[64566483] 'compare' (duration: 87.908396ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T13:23:21.529466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.443256ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-17T13:23:21.529616Z","caller":"traceutil/trace.go:171","msg":"trace[161156612] transaction","detail":"{read_only:false; response_revision:20417; number_of_response:1; }","duration":"182.043794ms","start":"2026-07-17T13:23:21.347543Z","end":"2026-07-17T13:23:21.529587Z","steps":["trace[161156612] 'process raft request' (duration: 58.365832ms)","trace[161156612] 'compare' (duration: 123.185868ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T13:23:21.691049Z","caller":"traceutil/trace.go:171","msg":"trace[661659495] linearizableReadLoop","detail":"{readStateIndex:21100; appliedIndex:21099; }","duration":"237.018442ms","start":"2026-07-17T13:23:21.454001Z","end":"2026-07-17T13:23:21.691019Z","steps":["trace[661659495] 'read index received' (duration: 233.931988ms)","trace[661659495] 'applied index is now lower than readState.Index' (duration: 3.085114ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T13:23:21.691118Z","caller":"traceutil/trace.go:171","msg":"trace[2061866653] transaction","detail":"{read_only:false; response_revision:20418; number_of_response:1; }","duration":"343.370611ms","start":"2026-07-17T13:23:21.347707Z","end":"2026-07-17T13:23:21.691078Z","steps":["trace[2061866653] 'process raft request' (duration: 340.226156ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:23:21.691296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:23:21.347697Z","time spent":"343.504775ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T13:23:21.691372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.347701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-07-17T13:23:21.691461Z","caller":"traceutil/trace.go:171","msg":"trace[928822719] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20418; }","duration":"237.492225ms","start":"2026-07-17T13:23:21.453946Z","end":"2026-07-17T13:23:21.691438Z","steps":["trace[928822719] 'agreement among raft nodes before linearized reading' (duration: 237.217058ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:23:21.694311Z","caller":"traceutil/trace.go:171","msg":"trace[26413207] transaction","detail":"{read_only:false; response_revision:20419; number_of_response:1; }","duration":"158.836121ms","start":"2026-07-17T13:23:21.535448Z","end":"2026-07-17T13:23:21.694284Z","steps":["trace[26413207] 'process raft request' (duration: 158.706137ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:23:21.694755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.117719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-17T13:23:21.694849Z","caller":"traceutil/trace.go:171","msg":"trace[1302304058] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:20419; }","duration":"235.265353ms","start":"2026-07-17T13:23:21.459561Z","end":"2026-07-17T13:23:21.694826Z","steps":["trace[1302304058] 'agreement among raft nodes before linearized reading' (duration: 235.108259ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:23:21.963884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.608487ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-17T13:23:21.964188Z","caller":"traceutil/trace.go:171","msg":"trace[1354177548] transaction","detail":"{read_only:false; response_revision:20420; number_of_response:1; }","duration":"267.36927ms","start":"2026-07-17T13:23:21.696774Z","end":"2026-07-17T13:23:21.964144Z","steps":["trace[1354177548] 'process raft request' (duration: 135.378552ms)","trace[1354177548] 'compare' (duration: 131.129845ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T13:27:20.277391Z","caller":"traceutil/trace.go:171","msg":"trace[2110188733] linearizableReadLoop","detail":"{readStateIndex:23630; appliedIndex:23629; }","duration":"182.137416ms","start":"2026-07-17T13:27:20.095226Z","end":"2026-07-17T13:27:20.277364Z","steps":["trace[2110188733] 'read index received' (duration: 181.893629ms)","trace[2110188733] 'applied index is now lower than readState.Index' (duration: 242.787µs)"],"step_count":2} {"level":"info","ts":"2026-07-17T13:27:20.27744Z","caller":"traceutil/trace.go:171","msg":"trace[471201864] transaction","detail":"{read_only:false; response_revision:22875; number_of_response:1; }","duration":"259.037803ms","start":"2026-07-17T13:27:20.018371Z","end":"2026-07-17T13:27:20.277409Z","steps":["trace[471201864] 'process raft request' (duration: 258.807757ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:27:20.277583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.31886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-17T13:27:20.277631Z","caller":"traceutil/trace.go:171","msg":"trace[605092669] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:22875; }","duration":"182.432664ms","start":"2026-07-17T13:27:20.095185Z","end":"2026-07-17T13:27:20.277618Z","steps":["trace[605092669] 'agreement among raft nodes before linearized reading' (duration: 182.324661ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:27:20.277683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.815269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1989"} {"level":"info","ts":"2026-07-17T13:27:20.277796Z","caller":"traceutil/trace.go:171","msg":"trace[1822773020] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:22875; }","duration":"129.992625ms","start":"2026-07-17T13:27:20.14778Z","end":"2026-07-17T13:27:20.277772Z","steps":["trace[1822773020] 'agreement among raft nodes before linearized reading' (duration: 129.772939ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:27:23.62267Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20114} {"level":"info","ts":"2026-07-17T13:27:23.740085Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20114,"took":"112.284592ms","hash":3391913822,"current-db-size-bytes":57769984,"current-db-size":"58 MB","current-db-size-in-use-bytes":42790912,"current-db-size-in-use":"43 MB"} {"level":"info","ts":"2026-07-17T13:27:23.740141Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3391913822,"revision":20114,"compact-revision":17639} {"level":"info","ts":"2026-07-17T13:30:59.367145Z","caller":"traceutil/trace.go:171","msg":"trace[1139428890] linearizableReadLoop","detail":"{readStateIndex:25894; appliedIndex:25893; }","duration":"259.600222ms","start":"2026-07-17T13:30:59.107517Z","end":"2026-07-17T13:30:59.367118Z","steps":["trace[1139428890] 'read index received' (duration: 259.084828ms)","trace[1139428890] 'applied index is now lower than readState.Index' (duration: 514.404µs)"],"step_count":2} {"level":"info","ts":"2026-07-17T13:30:59.367282Z","caller":"traceutil/trace.go:171","msg":"trace[1322330487] transaction","detail":"{read_only:false; response_revision:25080; number_of_response:1; }","duration":"401.849362ms","start":"2026-07-17T13:30:58.965421Z","end":"2026-07-17T13:30:59.36727Z","steps":["trace[1322330487] 'process raft request' (duration: 401.331957ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:30:59.367389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:30:58.965386Z","time spent":"401.925644ms","remote":"127.0.0.1:55152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418362,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T13:30:59.367792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.271032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-17T13:30:59.367842Z","caller":"traceutil/trace.go:171","msg":"trace[439451463] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:25080; }","duration":"260.375264ms","start":"2026-07-17T13:30:59.107454Z","end":"2026-07-17T13:30:59.367829Z","steps":["trace[439451463] 'agreement among raft nodes before linearized reading' (duration: 260.298392ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:30:59.367462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.793156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-17T13:30:59.36814Z","caller":"traceutil/trace.go:171","msg":"trace[1900169857] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:25080; }","duration":"224.494775ms","start":"2026-07-17T13:30:59.143627Z","end":"2026-07-17T13:30:59.368121Z","steps":["trace[1900169857] 'agreement among raft nodes before linearized reading' (duration: 223.694953ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:30:59.983907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.627202ms","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-07-17T13:30:59.984155Z","caller":"traceutil/trace.go:171","msg":"trace[1462309666] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:25082; }","duration":"239.890049ms","start":"2026-07-17T13:30:59.744241Z","end":"2026-07-17T13:30:59.984131Z","steps":["trace[1462309666] 'range keys from in-memory index tree' (duration: 239.607212ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:30:59.984688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.079437ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-17T13:30:59.98487Z","caller":"traceutil/trace.go:171","msg":"trace[1904386405] transaction","detail":"{read_only:false; response_revision:25084; number_of_response:1; }","duration":"280.251211ms","start":"2026-07-17T13:30:59.704604Z","end":"2026-07-17T13:30:59.984855Z","steps":["trace[1904386405] 'process raft request' (duration: 280.184619ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:30:59.984903Z","caller":"traceutil/trace.go:171","msg":"trace[863092671] transaction","detail":"{read_only:false; response_revision:25083; number_of_response:1; }","duration":"346.817105ms","start":"2026-07-17T13:30:59.63804Z","end":"2026-07-17T13:30:59.984858Z","steps":["trace[863092671] 'process raft request' (duration: 115.479451ms)","trace[863092671] 'compare' (duration: 230.920253ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T13:30:59.985216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:30:59.63801Z","time spent":"347.046142ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T13:30:59.985006Z","caller":"traceutil/trace.go:171","msg":"trace[931831614] linearizableReadLoop","detail":"{readStateIndex:25897; appliedIndex:25895; }","duration":"315.218485ms","start":"2026-07-17T13:30:59.669773Z","end":"2026-07-17T13:30:59.984991Z","steps":["trace[931831614] 'read index received' (duration: 11.96469ms)","trace[931831614] 'applied index is now lower than readState.Index' (duration: 303.251245ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T13:30:59.985564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.794441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-17T13:30:59.985673Z","caller":"traceutil/trace.go:171","msg":"trace[68128521] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25084; }","duration":"315.871523ms","start":"2026-07-17T13:30:59.669725Z","end":"2026-07-17T13:30:59.985597Z","steps":["trace[68128521] 'agreement among raft nodes before linearized reading' (duration: 315.307697ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:30:59.985718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:30:59.669712Z","time spent":"315.994217ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-17T13:31:00.352041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.234581ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-17T13:31:00.352236Z","caller":"traceutil/trace.go:171","msg":"trace[1731257726] transaction","detail":"{read_only:false; response_revision:25085; number_of_response:1; }","duration":"544.43518ms","start":"2026-07-17T13:30:59.807774Z","end":"2026-07-17T13:31:00.352209Z","steps":["trace[1731257726] 'process raft request' (duration: 357.912091ms)","trace[1731257726] 'compare' (duration: 185.930183ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T13:31:00.352424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:30:59.807745Z","time spent":"544.608765ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T13:31:00.352417Z","caller":"traceutil/trace.go:171","msg":"trace[747805070] linearizableReadLoop","detail":"{readStateIndex:25900; appliedIndex:25898; }","duration":"367.021141ms","start":"2026-07-17T13:30:59.985378Z","end":"2026-07-17T13:31:00.352399Z","steps":["trace[747805070] 'read index received' (duration: 180.368569ms)","trace[747805070] 'applied index is now lower than readState.Index' (duration: 186.651682ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T13:31:00.352547Z","caller":"traceutil/trace.go:171","msg":"trace[2070149423] transaction","detail":"{read_only:false; response_revision:25089; number_of_response:1; }","duration":"221.994046ms","start":"2026-07-17T13:31:00.130541Z","end":"2026-07-17T13:31:00.352535Z","steps":["trace[2070149423] 'process raft request' (duration: 221.809981ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:00.352734Z","caller":"traceutil/trace.go:171","msg":"trace[1358965233] transaction","detail":"{read_only:false; response_revision:25086; number_of_response:1; }","duration":"441.73316ms","start":"2026-07-17T13:30:59.910989Z","end":"2026-07-17T13:31:00.352722Z","steps":["trace[1358965233] 'process raft request' (duration: 441.174335ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:00.352531Z","caller":"traceutil/trace.go:171","msg":"trace[759156868] transaction","detail":"{read_only:false; response_revision:25087; number_of_response:1; }","duration":"363.094824ms","start":"2026-07-17T13:30:59.989389Z","end":"2026-07-17T13:31:00.352484Z","steps":["trace[759156868] 'process raft request' (duration: 362.886438ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:00.352836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.255841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/\" range_end:\"/registry/monitoring.coreos.com/alertmanagers0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-07-17T13:31:00.352856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:30:59.91096Z","time spent":"441.813513ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T13:31:00.352876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.16373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-17T13:31:00.352877Z","caller":"traceutil/trace.go:171","msg":"trace[1327065666] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/; range_end:/registry/monitoring.coreos.com/alertmanagers0; response_count:0; response_revision:25089; }","duration":"566.365494ms","start":"2026-07-17T13:30:59.7865Z","end":"2026-07-17T13:31:00.352865Z","steps":["trace[1327065666] 'agreement among raft nodes before linearized reading' (duration: 566.292192ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:00.352901Z","caller":"traceutil/trace.go:171","msg":"trace[15079165] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25089; }","duration":"361.192141ms","start":"2026-07-17T13:30:59.991702Z","end":"2026-07-17T13:31:00.352895Z","steps":["trace[15079165] 'agreement among raft nodes before linearized reading' (duration: 361.14311ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:00.35292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:30:59.786473Z","time spent":"566.437297ms","remote":"127.0.0.1:34928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":1,"response size":32,"request content":"key:\"/registry/monitoring.coreos.com/alertmanagers/\" range_end:\"/registry/monitoring.coreos.com/alertmanagers0\" count_only:true "} {"level":"warn","ts":"2026-07-17T13:31:00.352943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:30:59.991671Z","time spent":"361.268773ms","remote":"127.0.0.1:33658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-17T13:31:00.353044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:30:59.989362Z","time spent":"363.507765ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T13:31:00.352531Z","caller":"traceutil/trace.go:171","msg":"trace[281233300] transaction","detail":"{read_only:false; response_revision:25088; number_of_response:1; }","duration":"329.459077ms","start":"2026-07-17T13:31:00.023025Z","end":"2026-07-17T13:31:00.352484Z","steps":["trace[281233300] 'process raft request' (duration: 329.288352ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:00.353168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.506883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-07-17T13:31:00.353192Z","caller":"traceutil/trace.go:171","msg":"trace[316940919] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25089; }","duration":"270.575344ms","start":"2026-07-17T13:31:00.082611Z","end":"2026-07-17T13:31:00.353187Z","steps":["trace[316940919] 'agreement among raft nodes before linearized reading' (duration: 270.42918ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:00.353127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.174031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-07-17T13:31:00.353229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:31:00.023004Z","time spent":"330.178847ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T13:31:00.353242Z","caller":"traceutil/trace.go:171","msg":"trace[997582961] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25089; }","duration":"218.336825ms","start":"2026-07-17T13:31:00.134881Z","end":"2026-07-17T13:31:00.353218Z","steps":["trace[997582961] 'agreement among raft nodes before linearized reading' (duration: 218.050187ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:00.56048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.628407ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-17T13:31:00.560616Z","caller":"traceutil/trace.go:171","msg":"trace[15943153] linearizableReadLoop","detail":"{readStateIndex:25905; appliedIndex:25904; }","duration":"146.064695ms","start":"2026-07-17T13:31:00.414529Z","end":"2026-07-17T13:31:00.560594Z","steps":["trace[15943153] 'read index received' (duration: 43.132389ms)","trace[15943153] 'applied index is now lower than readState.Index' (duration: 102.930686ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T13:31:00.561107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.549448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18434"} {"level":"info","ts":"2026-07-17T13:31:00.561135Z","caller":"traceutil/trace.go:171","msg":"trace[2075760974] transaction","detail":"{read_only:false; response_revision:25091; number_of_response:1; }","duration":"203.224009ms","start":"2026-07-17T13:31:00.357891Z","end":"2026-07-17T13:31:00.561115Z","steps":["trace[2075760974] 'process raft request' (duration: 99.845381ms)","trace[2075760974] 'compare' (duration: 102.468743ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T13:31:00.561197Z","caller":"traceutil/trace.go:171","msg":"trace[765631146] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:25091; }","duration":"146.708202ms","start":"2026-07-17T13:31:00.414469Z","end":"2026-07-17T13:31:00.561177Z","steps":["trace[765631146] 'agreement among raft nodes before linearized reading' (duration: 146.436034ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:00.561212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.407713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" ","response":"range_response_count:1 size:1858"} {"level":"info","ts":"2026-07-17T13:31:00.561297Z","caller":"traceutil/trace.go:171","msg":"trace[1953415179] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0; range_end:; response_count:1; response_revision:25091; }","duration":"122.522755ms","start":"2026-07-17T13:31:00.438753Z","end":"2026-07-17T13:31:00.561275Z","steps":["trace[1953415179] 'agreement among raft nodes before linearized reading' (duration: 122.277179ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:00.758651Z","caller":"traceutil/trace.go:171","msg":"trace[1369529567] transaction","detail":"{read_only:false; response_revision:25094; number_of_response:1; }","duration":"179.670511ms","start":"2026-07-17T13:31:00.578942Z","end":"2026-07-17T13:31:00.758613Z","steps":["trace[1369529567] 'process raft request' (duration: 179.622779ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:00.758816Z","caller":"traceutil/trace.go:171","msg":"trace[1826172984] transaction","detail":"{read_only:false; response_revision:25093; number_of_response:1; }","duration":"179.877536ms","start":"2026-07-17T13:31:00.578895Z","end":"2026-07-17T13:31:00.758773Z","steps":["trace[1826172984] 'process raft request' (duration: 179.605099ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:00.7588Z","caller":"traceutil/trace.go:171","msg":"trace[54446633] transaction","detail":"{read_only:false; response_revision:25092; number_of_response:1; }","duration":"191.593339ms","start":"2026-07-17T13:31:00.567166Z","end":"2026-07-17T13:31:00.75876Z","steps":["trace[54446633] 'process raft request' (duration: 136.990354ms)","trace[54446633] 'compare' (duration: 54.097401ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T13:31:02.021708Z","caller":"traceutil/trace.go:171","msg":"trace[1294999486] transaction","detail":"{read_only:false; response_revision:25096; number_of_response:1; }","duration":"196.863114ms","start":"2026-07-17T13:31:01.824811Z","end":"2026-07-17T13:31:02.021674Z","steps":["trace[1294999486] 'process raft request' (duration: 196.670929ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:02.39624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.035714ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:30"} {"level":"info","ts":"2026-07-17T13:31:02.576977Z","caller":"traceutil/trace.go:171","msg":"trace[1257559139] linearizableReadLoop","detail":"{readStateIndex:25915; appliedIndex:25912; }","duration":"217.495982ms","start":"2026-07-17T13:31:02.35945Z","end":"2026-07-17T13:31:02.576946Z","steps":["trace[1257559139] 'read index received' (duration: 36.035082ms)","trace[1257559139] 'applied index is now lower than readState.Index' (duration: 181.45899ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T13:31:02.57711Z","caller":"traceutil/trace.go:171","msg":"trace[1680917953] transaction","detail":"{read_only:false; response_revision:25100; number_of_response:1; }","duration":"217.783401ms","start":"2026-07-17T13:31:02.359294Z","end":"2026-07-17T13:31:02.577078Z","steps":["trace[1680917953] 'process raft request' (duration: 217.312388ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:02.577369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.904114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-17T13:31:02.57743Z","caller":"traceutil/trace.go:171","msg":"trace[833284867] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25102; }","duration":"218.046087ms","start":"2026-07-17T13:31:02.359372Z","end":"2026-07-17T13:31:02.577418Z","steps":["trace[833284867] 'agreement among raft nodes before linearized reading' (duration: 217.859362ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:02.577539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.054754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-07-17T13:31:02.577581Z","caller":"traceutil/trace.go:171","msg":"trace[36257259] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25102; }","duration":"191.149896ms","start":"2026-07-17T13:31:02.38642Z","end":"2026-07-17T13:31:02.577569Z","steps":["trace[36257259] 'agreement among raft nodes before linearized reading' (duration: 191.015893ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:02.577175Z","caller":"traceutil/trace.go:171","msg":"trace[1827136218] transaction","detail":"{read_only:false; response_revision:25102; number_of_response:1; }","duration":"217.374139ms","start":"2026-07-17T13:31:02.359793Z","end":"2026-07-17T13:31:02.577167Z","steps":["trace[1827136218] 'process raft request' (duration: 217.094992ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:02.577695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.092167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-17T13:31:02.577719Z","caller":"traceutil/trace.go:171","msg":"trace[1021228022] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:25102; }","duration":"170.154098ms","start":"2026-07-17T13:31:02.407559Z","end":"2026-07-17T13:31:02.577713Z","steps":["trace[1021228022] 'agreement among raft nodes before linearized reading' (duration: 170.095347ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:02.577159Z","caller":"traceutil/trace.go:171","msg":"trace[1220925650] transaction","detail":"{read_only:false; response_revision:25101; number_of_response:1; }","duration":"217.426971ms","start":"2026-07-17T13:31:02.359693Z","end":"2026-07-17T13:31:02.57712Z","steps":["trace[1220925650] 'process raft request' (duration: 217.128593ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:02.728602Z","caller":"traceutil/trace.go:171","msg":"trace[1488401514] linearizableReadLoop","detail":"{readStateIndex:25920; appliedIndex:25917; }","duration":"142.873386ms","start":"2026-07-17T13:31:02.585705Z","end":"2026-07-17T13:31:02.728578Z","steps":["trace[1488401514] 'read index received' (duration: 22.52649ms)","trace[1488401514] 'applied index is now lower than readState.Index' (duration: 120.345736ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T13:31:02.728639Z","caller":"traceutil/trace.go:171","msg":"trace[539175915] transaction","detail":"{read_only:false; response_revision:25105; number_of_response:1; }","duration":"144.925004ms","start":"2026-07-17T13:31:02.583673Z","end":"2026-07-17T13:31:02.728598Z","steps":["trace[539175915] 'process raft request' (duration: 144.841951ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:02.728653Z","caller":"traceutil/trace.go:171","msg":"trace[1277522533] transaction","detail":"{read_only:false; response_revision:25104; number_of_response:1; }","duration":"146.531767ms","start":"2026-07-17T13:31:02.582062Z","end":"2026-07-17T13:31:02.728593Z","steps":["trace[1277522533] 'process raft request' (duration: 144.771769ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:02.728804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.083162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-07-17T13:31:02.728842Z","caller":"traceutil/trace.go:171","msg":"trace[1595960470] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:25105; }","duration":"143.163344ms","start":"2026-07-17T13:31:02.585669Z","end":"2026-07-17T13:31:02.728832Z","steps":["trace[1595960470] 'agreement among raft nodes before linearized reading' (duration: 143.00553ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:03.039708Z","caller":"traceutil/trace.go:171","msg":"trace[1890348751] transaction","detail":"{read_only:false; response_revision:25107; number_of_response:1; }","duration":"275.414518ms","start":"2026-07-17T13:31:02.764249Z","end":"2026-07-17T13:31:03.039664Z","steps":["trace[1890348751] 'process raft request' (duration: 243.035306ms)","trace[1890348751] 'compare' (duration: 31.919529ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T13:31:03.04086Z","caller":"traceutil/trace.go:171","msg":"trace[1332185778] transaction","detail":"{read_only:false; response_revision:25108; number_of_response:1; }","duration":"276.57538ms","start":"2026-07-17T13:31:02.764247Z","end":"2026-07-17T13:31:03.040823Z","steps":["trace[1332185778] 'process raft request' (duration: 275.327546ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:03.042127Z","caller":"traceutil/trace.go:171","msg":"trace[1823333337] transaction","detail":"{read_only:false; response_revision:25109; number_of_response:1; }","duration":"273.842415ms","start":"2026-07-17T13:31:02.768252Z","end":"2026-07-17T13:31:03.042095Z","steps":["trace[1823333337] 'process raft request' (duration: 273.742742ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:03.542005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.259691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-07-17T13:31:03.54208Z","caller":"traceutil/trace.go:171","msg":"trace[518552591] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25110; }","duration":"137.427916ms","start":"2026-07-17T13:31:03.404634Z","end":"2026-07-17T13:31:03.542062Z","steps":["trace[518552591] 'range keys from in-memory index tree' (duration: 136.983904ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:03.853317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.40871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-17T13:31:03.853393Z","caller":"traceutil/trace.go:171","msg":"trace[1359199138] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25111; }","duration":"160.494742ms","start":"2026-07-17T13:31:03.69288Z","end":"2026-07-17T13:31:03.853374Z","steps":["trace[1359199138] 'range keys from in-memory index tree' (duration: 160.284526ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:03.853852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.754282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-07-17T13:31:03.853949Z","caller":"traceutil/trace.go:171","msg":"trace[1219150033] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25111; }","duration":"138.909597ms","start":"2026-07-17T13:31:03.715017Z","end":"2026-07-17T13:31:03.853926Z","steps":["trace[1219150033] 'range keys from in-memory index tree' (duration: 138.540397ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:04.502882Z","caller":"traceutil/trace.go:171","msg":"trace[1339696512] transaction","detail":"{read_only:false; response_revision:25115; number_of_response:1; }","duration":"100.16111ms","start":"2026-07-17T13:31:04.402694Z","end":"2026-07-17T13:31:04.502855Z","steps":["trace[1339696512] 'process raft request' (duration: 99.974695ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:04.775083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.753823ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-17T13:31:04.775176Z","caller":"traceutil/trace.go:171","msg":"trace[1709458799] transaction","detail":"{read_only:false; response_revision:25116; number_of_response:1; }","duration":"192.207115ms","start":"2026-07-17T13:31:04.582951Z","end":"2026-07-17T13:31:04.775158Z","steps":["trace[1709458799] 'process raft request' (duration: 61.302969ms)","trace[1709458799] 'compare' (duration: 130.609898ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T13:31:04.838955Z","caller":"traceutil/trace.go:171","msg":"trace[1841270155] transaction","detail":"{read_only:false; response_revision:25117; number_of_response:1; }","duration":"254.254905ms","start":"2026-07-17T13:31:04.584653Z","end":"2026-07-17T13:31:04.838908Z","steps":["trace[1841270155] 'process raft request' (duration: 253.943576ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:04.839042Z","caller":"traceutil/trace.go:171","msg":"trace[1534968777] linearizableReadLoop","detail":"{readStateIndex:25933; appliedIndex:25930; }","duration":"226.438748ms","start":"2026-07-17T13:31:04.612565Z","end":"2026-07-17T13:31:04.839003Z","steps":["trace[1534968777] 'read index received' (duration: 31.711213ms)","trace[1534968777] 'applied index is now lower than readState.Index' (duration: 194.726245ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T13:31:04.8395Z","caller":"traceutil/trace.go:171","msg":"trace[203439806] transaction","detail":"{read_only:false; response_revision:25118; number_of_response:1; }","duration":"252.746114ms","start":"2026-07-17T13:31:04.586743Z","end":"2026-07-17T13:31:04.839489Z","steps":["trace[203439806] 'process raft request' (duration: 252.013804ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:04.839804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.237911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-07-17T13:31:04.839859Z","caller":"traceutil/trace.go:171","msg":"trace[1322518694] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25118; }","duration":"227.349124ms","start":"2026-07-17T13:31:04.612497Z","end":"2026-07-17T13:31:04.839846Z","steps":["trace[1322518694] 'agreement among raft nodes before linearized reading' (duration: 227.183439ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:04.84002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.71585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-17T13:31:04.84005Z","caller":"traceutil/trace.go:171","msg":"trace[306346437] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25118; }","duration":"106.829553ms","start":"2026-07-17T13:31:04.733213Z","end":"2026-07-17T13:31:04.840043Z","steps":["trace[306346437] 'agreement among raft nodes before linearized reading' (duration: 106.746751ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:04.840178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.563885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-17T13:31:04.840206Z","caller":"traceutil/trace.go:171","msg":"trace[679751886] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25118; }","duration":"106.610997ms","start":"2026-07-17T13:31:04.733587Z","end":"2026-07-17T13:31:04.840198Z","steps":["trace[679751886] 'agreement among raft nodes before linearized reading' (duration: 106.517225ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:05.090714Z","caller":"traceutil/trace.go:171","msg":"trace[120148570] transaction","detail":"{read_only:false; response_revision:25119; number_of_response:1; }","duration":"245.018761ms","start":"2026-07-17T13:31:04.84565Z","end":"2026-07-17T13:31:05.090668Z","steps":["trace[120148570] 'process raft request' (duration: 199.911959ms)","trace[120148570] 'compare' (duration: 44.479645ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T13:31:05.090758Z","caller":"traceutil/trace.go:171","msg":"trace[1018791953] transaction","detail":"{read_only:false; response_revision:25121; number_of_response:1; }","duration":"244.22945ms","start":"2026-07-17T13:31:04.84649Z","end":"2026-07-17T13:31:05.09072Z","steps":["trace[1018791953] 'process raft request' (duration: 244.137177ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:05.090807Z","caller":"traceutil/trace.go:171","msg":"trace[1969933637] transaction","detail":"{read_only:false; response_revision:25120; number_of_response:1; }","duration":"244.547588ms","start":"2026-07-17T13:31:04.84621Z","end":"2026-07-17T13:31:05.090758Z","steps":["trace[1969933637] 'process raft request' (duration: 244.28106ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:05.090965Z","caller":"traceutil/trace.go:171","msg":"trace[462125911] transaction","detail":"{read_only:false; response_revision:25122; number_of_response:1; }","duration":"244.288771ms","start":"2026-07-17T13:31:04.846635Z","end":"2026-07-17T13:31:05.090924Z","steps":["trace[462125911] 'process raft request' (duration: 244.042434ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:17.60926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.319385ms","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-07-17T13:31:17.609344Z","caller":"traceutil/trace.go:171","msg":"trace[988457682] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25206; }","duration":"459.455859ms","start":"2026-07-17T13:31:17.149869Z","end":"2026-07-17T13:31:17.609325Z","steps":["trace[988457682] 'range keys from in-memory index tree' (duration: 459.14419ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:17.609569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.510678ms","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-07-17T13:31:17.609635Z","caller":"traceutil/trace.go:171","msg":"trace[1080690025] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25206; }","duration":"464.605531ms","start":"2026-07-17T13:31:17.14501Z","end":"2026-07-17T13:31:17.609615Z","steps":["trace[1080690025] 'range keys from in-memory index tree' (duration: 464.401455ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:17.609664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:31:17.144994Z","time spent":"464.664012ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-17T13:31:17.60981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.976684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-07-17T13:31:17.60986Z","caller":"traceutil/trace.go:171","msg":"trace[1266728859] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25206; }","duration":"460.049035ms","start":"2026-07-17T13:31:17.149796Z","end":"2026-07-17T13:31:17.609845Z","steps":["trace[1266728859] 'range keys from in-memory index tree' (duration: 459.821549ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:17.609893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:31:17.149785Z","time spent":"460.100236ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-17T13:31:17.609926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.301523ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-17T13:31:17.610278Z","caller":"traceutil/trace.go:171","msg":"trace[2074667065] transaction","detail":"{read_only:false; response_revision:25207; number_of_response:1; }","duration":"421.131774ms","start":"2026-07-17T13:31:17.18913Z","end":"2026-07-17T13:31:17.610262Z","steps":["trace[2074667065] 'process raft request' (duration: 181.430589ms)","trace[2074667065] 'compare' (duration: 239.087408ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T13:31:17.610276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:31:17.149847Z","time spent":"460.411256ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-17T13:31:17.610341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:31:17.189103Z","time spent":"421.205855ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T13:31:17.896551Z","caller":"traceutil/trace.go:171","msg":"trace[134750603] transaction","detail":"{read_only:false; response_revision:25208; number_of_response:1; }","duration":"707.057821ms","start":"2026-07-17T13:31:17.189449Z","end":"2026-07-17T13:31:17.896507Z","steps":["trace[134750603] 'process raft request' (duration: 679.674677ms)","trace[134750603] 'compare' (duration: 27.179339ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T13:31:17.896575Z","caller":"traceutil/trace.go:171","msg":"trace[199681793] linearizableReadLoop","detail":"{readStateIndex:26026; appliedIndex:26024; }","duration":"694.463053ms","start":"2026-07-17T13:31:17.202086Z","end":"2026-07-17T13:31:17.896549Z","steps":["trace[199681793] 'read index received' (duration: 168.463721ms)","trace[199681793] 'applied index is now lower than readState.Index' (duration: 525.998112ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T13:31:17.89674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:31:17.189417Z","time spent":"707.223306ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T13:31:17.897035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"694.939767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-07-17T13:31:17.89713Z","caller":"traceutil/trace.go:171","msg":"trace[1242296772] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25208; }","duration":"695.083031ms","start":"2026-07-17T13:31:17.202024Z","end":"2026-07-17T13:31:17.897107Z","steps":["trace[1242296772] 'agreement among raft nodes before linearized reading' (duration: 694.795923ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:17.897199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:31:17.202002Z","time spent":"695.181614ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-17T13:31:17.897355Z","caller":"traceutil/trace.go:171","msg":"trace[56779184] transaction","detail":"{read_only:false; response_revision:25209; number_of_response:1; }","duration":"284.409886ms","start":"2026-07-17T13:31:17.61289Z","end":"2026-07-17T13:31:17.8973Z","steps":["trace[56779184] 'process raft request' (duration: 283.603234ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:17.897947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.612712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-17T13:31:17.898022Z","caller":"traceutil/trace.go:171","msg":"trace[1908965575] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:25211; }","duration":"496.724945ms","start":"2026-07-17T13:31:17.401277Z","end":"2026-07-17T13:31:17.898002Z","steps":["trace[1908965575] 'agreement among raft nodes before linearized reading' (duration: 496.593542ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:17.898033Z","caller":"traceutil/trace.go:171","msg":"trace[1298898249] transaction","detail":"{read_only:false; response_revision:25211; number_of_response:1; }","duration":"282.490103ms","start":"2026-07-17T13:31:17.615503Z","end":"2026-07-17T13:31:17.897993Z","steps":["trace[1298898249] 'process raft request' (duration: 282.236776ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:17.898085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.183497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-17T13:31:17.898149Z","caller":"traceutil/trace.go:171","msg":"trace[696196216] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:25211; }","duration":"322.30907ms","start":"2026-07-17T13:31:17.575822Z","end":"2026-07-17T13:31:17.898131Z","steps":["trace[696196216] 'agreement among raft nodes before linearized reading' (duration: 322.181106ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:17.898188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.83078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:533"} {"level":"warn","ts":"2026-07-17T13:31:17.898198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:31:17.575733Z","time spent":"322.454594ms","remote":"127.0.0.1:59880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":30,"request content":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true "} {"level":"warn","ts":"2026-07-17T13:31:17.89808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:31:17.401257Z","time spent":"496.807318ms","remote":"127.0.0.1:55058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-07-17T13:31:17.898244Z","caller":"traceutil/trace.go:171","msg":"trace[1927067860] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:25211; }","duration":"152.966395ms","start":"2026-07-17T13:31:17.745263Z","end":"2026-07-17T13:31:17.898229Z","steps":["trace[1927067860] 'agreement among raft nodes before linearized reading' (duration: 152.634865ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:17.898383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.413464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-17T13:31:17.898453Z","caller":"traceutil/trace.go:171","msg":"trace[2002861972] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:0; response_revision:25211; }","duration":"289.529157ms","start":"2026-07-17T13:31:17.608905Z","end":"2026-07-17T13:31:17.898434Z","steps":["trace[2002861972] 'agreement among raft nodes before linearized reading' (duration: 289.062794ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:17.897819Z","caller":"traceutil/trace.go:171","msg":"trace[417686469] transaction","detail":"{read_only:false; response_revision:25210; number_of_response:1; }","duration":"283.339496ms","start":"2026-07-17T13:31:17.614446Z","end":"2026-07-17T13:31:17.897785Z","steps":["trace[417686469] 'process raft request' (duration: 282.710109ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:18.493653Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6277067284459498803,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-17T13:31:18.557917Z","caller":"traceutil/trace.go:171","msg":"trace[1530871754] transaction","detail":"{read_only:false; response_revision:25214; number_of_response:1; }","duration":"580.877754ms","start":"2026-07-17T13:31:17.977001Z","end":"2026-07-17T13:31:18.557879Z","steps":["trace[1530871754] 'process raft request' (duration: 580.665188ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:18.558275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:31:17.976972Z","time spent":"581.140141ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T13:31:18.578622Z","caller":"traceutil/trace.go:171","msg":"trace[1888809847] linearizableReadLoop","detail":"{readStateIndex:26035; appliedIndex:26031; }","duration":"585.927644ms","start":"2026-07-17T13:31:17.992664Z","end":"2026-07-17T13:31:18.578592Z","steps":["trace[1888809847] 'read index received' (duration: 565.029158ms)","trace[1888809847] 'applied index is now lower than readState.Index' (duration: 20.897306ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T13:31:18.578938Z","caller":"traceutil/trace.go:171","msg":"trace[20775557] transaction","detail":"{read_only:false; response_revision:25215; number_of_response:1; }","duration":"494.025061ms","start":"2026-07-17T13:31:18.084901Z","end":"2026-07-17T13:31:18.578926Z","steps":["trace[20775557] 'process raft request' (duration: 493.424735ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:18.579065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:31:18.084868Z","time spent":"494.100493ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T13:31:18.579264Z","caller":"traceutil/trace.go:171","msg":"trace[966458660] transaction","detail":"{read_only:false; response_revision:25216; number_of_response:1; }","duration":"493.043904ms","start":"2026-07-17T13:31:18.08621Z","end":"2026-07-17T13:31:18.579254Z","steps":["trace[966458660] 'process raft request' (duration: 492.269213ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:18.579322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:31:18.086182Z","time spent":"493.105846ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T13:31:18.579442Z","caller":"traceutil/trace.go:171","msg":"trace[1507578089] transaction","detail":"{read_only:false; response_revision:25217; number_of_response:1; }","duration":"281.751043ms","start":"2026-07-17T13:31:18.29768Z","end":"2026-07-17T13:31:18.579431Z","steps":["trace[1507578089] 'process raft request' (duration: 280.839878ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:18.579666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.007773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-17T13:31:18.579703Z","caller":"traceutil/trace.go:171","msg":"trace[1144432553] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25218; }","duration":"587.094956ms","start":"2026-07-17T13:31:17.992595Z","end":"2026-07-17T13:31:18.579689Z","steps":["trace[1144432553] 'agreement among raft nodes before linearized reading' (duration: 587.035034ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:18.57973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:31:17.992563Z","time spent":"587.161697ms","remote":"127.0.0.1:33658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-17T13:31:18.579905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.933314ms","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-07-17T13:31:18.579938Z","caller":"traceutil/trace.go:171","msg":"trace[1648968619] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:25218; }","duration":"247.026916ms","start":"2026-07-17T13:31:18.3329Z","end":"2026-07-17T13:31:18.579927Z","steps":["trace[1648968619] 'agreement among raft nodes before linearized reading' (duration: 246.974084ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:18.580373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.392346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-17T13:31:18.580407Z","caller":"traceutil/trace.go:171","msg":"trace[1771659062] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:25218; }","duration":"137.470148ms","start":"2026-07-17T13:31:18.442927Z","end":"2026-07-17T13:31:18.580397Z","steps":["trace[1771659062] 'agreement among raft nodes before linearized reading' (duration: 137.413806ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:19.169597Z","caller":"traceutil/trace.go:171","msg":"trace[1792940998] transaction","detail":"{read_only:false; response_revision:25219; number_of_response:1; }","duration":"336.431929ms","start":"2026-07-17T13:31:18.833134Z","end":"2026-07-17T13:31:19.169566Z","steps":["trace[1792940998] 'process raft request' (duration: 336.240614ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:19.169787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:31:18.833106Z","time spent":"336.569763ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T13:31:19.180914Z","caller":"traceutil/trace.go:171","msg":"trace[431462163] linearizableReadLoop","detail":"{readStateIndex:26039; appliedIndex:26036; }","duration":"188.03132ms","start":"2026-07-17T13:31:18.992855Z","end":"2026-07-17T13:31:19.180887Z","steps":["trace[431462163] 'read index received' (duration: 176.507213ms)","trace[431462163] 'applied index is now lower than readState.Index' (duration: 11.522927ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T13:31:19.181Z","caller":"traceutil/trace.go:171","msg":"trace[55854021] transaction","detail":"{read_only:false; response_revision:25220; number_of_response:1; }","duration":"281.411864ms","start":"2026-07-17T13:31:18.899528Z","end":"2026-07-17T13:31:19.18094Z","steps":["trace[55854021] 'process raft request' (duration: 281.191798ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:19.18106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.185835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-17T13:31:19.181116Z","caller":"traceutil/trace.go:171","msg":"trace[79895807] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25221; }","duration":"188.301068ms","start":"2026-07-17T13:31:18.9928Z","end":"2026-07-17T13:31:19.181101Z","steps":["trace[79895807] 'agreement among raft nodes before linearized reading' (duration: 188.194855ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:19.181021Z","caller":"traceutil/trace.go:171","msg":"trace[308542776] transaction","detail":"{read_only:false; response_revision:25221; number_of_response:1; }","duration":"279.025137ms","start":"2026-07-17T13:31:18.901939Z","end":"2026-07-17T13:31:19.180964Z","steps":["trace[308542776] 'process raft request' (duration: 278.897624ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:19.644355Z","caller":"traceutil/trace.go:171","msg":"trace[872425131] transaction","detail":"{read_only:false; response_revision:25222; number_of_response:1; }","duration":"151.251477ms","start":"2026-07-17T13:31:19.493075Z","end":"2026-07-17T13:31:19.644327Z","steps":["trace[872425131] 'process raft request' (duration: 151.050911ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:19.764617Z","caller":"traceutil/trace.go:171","msg":"trace[1115681513] linearizableReadLoop","detail":"{readStateIndex:26041; appliedIndex:26040; }","duration":"113.192527ms","start":"2026-07-17T13:31:19.65139Z","end":"2026-07-17T13:31:19.764583Z","steps":["trace[1115681513] 'read index received' (duration: 63.423636ms)","trace[1115681513] 'applied index is now lower than readState.Index' (duration: 49.767551ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T13:31:19.764922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.508826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:1651"} {"level":"info","ts":"2026-07-17T13:31:19.765003Z","caller":"traceutil/trace.go:171","msg":"trace[1836941109] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:25223; }","duration":"113.629449ms","start":"2026-07-17T13:31:19.651353Z","end":"2026-07-17T13:31:19.764983Z","steps":["trace[1836941109] 'agreement among raft nodes before linearized reading' (duration: 113.402073ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:19.76521Z","caller":"traceutil/trace.go:171","msg":"trace[2090226985] transaction","detail":"{read_only:false; response_revision:25223; number_of_response:1; }","duration":"150.112705ms","start":"2026-07-17T13:31:19.615081Z","end":"2026-07-17T13:31:19.765193Z","steps":["trace[2090226985] 'process raft request' (duration: 99.792469ms)","trace[2090226985] 'compare' (duration: 49.494523ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T13:31:19.765728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.846317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:1651"} {"level":"info","ts":"2026-07-17T13:31:19.76577Z","caller":"traceutil/trace.go:171","msg":"trace[1198258202] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:25223; }","duration":"112.89999ms","start":"2026-07-17T13:31:19.652859Z","end":"2026-07-17T13:31:19.765759Z","steps":["trace[1198258202] 'agreement among raft nodes before linearized reading' (duration: 112.798887ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:20.037206Z","caller":"traceutil/trace.go:171","msg":"trace[1439425731] linearizableReadLoop","detail":"{readStateIndex:26043; appliedIndex:26042; }","duration":"150.195269ms","start":"2026-07-17T13:31:19.886977Z","end":"2026-07-17T13:31:20.037172Z","steps":["trace[1439425731] 'read index received' (duration: 149.89117ms)","trace[1439425731] 'applied index is now lower than readState.Index' (duration: 302.239µs)"],"step_count":2} {"level":"info","ts":"2026-07-17T13:31:20.037234Z","caller":"traceutil/trace.go:171","msg":"trace[207141002] transaction","detail":"{read_only:false; response_revision:25225; number_of_response:1; }","duration":"166.62329ms","start":"2026-07-17T13:31:19.870578Z","end":"2026-07-17T13:31:20.037201Z","steps":["trace[207141002] 'process raft request' (duration: 166.375534ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:20.037372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.362713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/roles/\" range_end:\"/registry/openstack.k-orc.cloud/roles0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-17T13:31:20.03745Z","caller":"traceutil/trace.go:171","msg":"trace[224624591] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/roles/; range_end:/registry/openstack.k-orc.cloud/roles0; response_count:0; response_revision:25225; }","duration":"150.498207ms","start":"2026-07-17T13:31:19.886932Z","end":"2026-07-17T13:31:20.03743Z","steps":["trace[224624591] 'agreement among raft nodes before linearized reading' (duration: 150.348753ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:20.048124Z","caller":"traceutil/trace.go:171","msg":"trace[2124509248] transaction","detail":"{read_only:false; response_revision:25226; number_of_response:1; }","duration":"143.044271ms","start":"2026-07-17T13:31:19.905045Z","end":"2026-07-17T13:31:20.048089Z","steps":["trace[2124509248] 'process raft request' (duration: 142.63606ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:20.048655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.793402ms","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-07-17T13:31:20.048698Z","caller":"traceutil/trace.go:171","msg":"trace[753783205] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25226; }","duration":"143.879274ms","start":"2026-07-17T13:31:19.904808Z","end":"2026-07-17T13:31:20.048687Z","steps":["trace[753783205] 'agreement among raft nodes before linearized reading' (duration: 143.716789ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:20.048919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.40273ms","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-07-17T13:31:20.04897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.982827ms","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-07-17T13:31:20.048993Z","caller":"traceutil/trace.go:171","msg":"trace[743915797] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25226; }","duration":"144.040688ms","start":"2026-07-17T13:31:19.904946Z","end":"2026-07-17T13:31:20.048986Z","steps":["trace[743915797] 'agreement among raft nodes before linearized reading' (duration: 143.818362ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:20.048992Z","caller":"traceutil/trace.go:171","msg":"trace[2096404344] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25226; }","duration":"143.558365ms","start":"2026-07-17T13:31:19.905415Z","end":"2026-07-17T13:31:20.048973Z","steps":["trace[2096404344] 'agreement among raft nodes before linearized reading' (duration: 143.328438ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:20.049262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.760412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"info","ts":"2026-07-17T13:31:20.049566Z","caller":"traceutil/trace.go:171","msg":"trace[2044303020] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:25226; }","duration":"111.104061ms","start":"2026-07-17T13:31:19.938429Z","end":"2026-07-17T13:31:20.049533Z","steps":["trace[2044303020] 'agreement among raft nodes before linearized reading' (duration: 110.385451ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:20.314957Z","caller":"traceutil/trace.go:171","msg":"trace[700521152] linearizableReadLoop","detail":"{readStateIndex:26049; appliedIndex:26045; }","duration":"218.466629ms","start":"2026-07-17T13:31:20.096463Z","end":"2026-07-17T13:31:20.31493Z","steps":["trace[700521152] 'read index received' (duration: 218.227813ms)","trace[700521152] 'applied index is now lower than readState.Index' (duration: 237.766µs)"],"step_count":2} {"level":"info","ts":"2026-07-17T13:31:20.314985Z","caller":"traceutil/trace.go:171","msg":"trace[459637334] transaction","detail":"{read_only:false; response_revision:25228; number_of_response:1; }","duration":"261.117444ms","start":"2026-07-17T13:31:20.053796Z","end":"2026-07-17T13:31:20.314913Z","steps":["trace[459637334] 'process raft request' (duration: 260.750724ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:20.315075Z","caller":"traceutil/trace.go:171","msg":"trace[568274018] transaction","detail":"{read_only:false; response_revision:25229; number_of_response:1; }","duration":"261.110674ms","start":"2026-07-17T13:31:20.053951Z","end":"2026-07-17T13:31:20.315061Z","steps":["trace[568274018] 'process raft request' (duration: 260.822716ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:20.315144Z","caller":"traceutil/trace.go:171","msg":"trace[1788589001] transaction","detail":"{read_only:false; response_revision:25231; number_of_response:1; }","duration":"260.166538ms","start":"2026-07-17T13:31:20.054953Z","end":"2026-07-17T13:31:20.315119Z","steps":["trace[1788589001] 'process raft request' (duration: 259.935251ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:20.315283Z","caller":"traceutil/trace.go:171","msg":"trace[1189799460] transaction","detail":"{read_only:false; response_revision:25230; number_of_response:1; }","duration":"260.679322ms","start":"2026-07-17T13:31:20.054596Z","end":"2026-07-17T13:31:20.315276Z","steps":["trace[1189799460] 'process raft request' (duration: 260.25093ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:20.315514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.024145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:562"} {"level":"info","ts":"2026-07-17T13:31:20.315598Z","caller":"traceutil/trace.go:171","msg":"trace[1521941809] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:25231; }","duration":"219.151038ms","start":"2026-07-17T13:31:20.096426Z","end":"2026-07-17T13:31:20.315577Z","steps":["trace[1521941809] 'agreement among raft nodes before linearized reading' (duration: 218.897731ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:20.372389Z","caller":"traceutil/trace.go:171","msg":"trace[568255854] transaction","detail":"{read_only:false; response_revision:25232; number_of_response:1; }","duration":"248.727773ms","start":"2026-07-17T13:31:20.12364Z","end":"2026-07-17T13:31:20.372368Z","steps":["trace[568255854] 'process raft request' (duration: 248.528238ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:20.372542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.316108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddresses/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddresses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-17T13:31:20.372639Z","caller":"traceutil/trace.go:171","msg":"trace[2013748160] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddresses/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddresses0; response_count:0; response_revision:25232; }","duration":"119.494243ms","start":"2026-07-17T13:31:20.25312Z","end":"2026-07-17T13:31:20.372614Z","steps":["trace[2013748160] 'agreement among raft nodes before linearized reading' (duration: 119.316268ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:20.372842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.465264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1989"} {"level":"info","ts":"2026-07-17T13:31:20.373013Z","caller":"traceutil/trace.go:171","msg":"trace[999778287] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:25232; }","duration":"224.634379ms","start":"2026-07-17T13:31:20.148253Z","end":"2026-07-17T13:31:20.372887Z","steps":["trace[999778287] 'agreement among raft nodes before linearized reading' (duration: 224.221568ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:20.430065Z","caller":"traceutil/trace.go:171","msg":"trace[1029321637] transaction","detail":"{read_only:false; response_revision:25233; number_of_response:1; }","duration":"109.25737ms","start":"2026-07-17T13:31:20.320718Z","end":"2026-07-17T13:31:20.429975Z","steps":["trace[1029321637] 'process raft request' (duration: 108.965812ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:20.430266Z","caller":"traceutil/trace.go:171","msg":"trace[1710804577] transaction","detail":"{read_only:false; response_revision:25234; number_of_response:1; }","duration":"109.433595ms","start":"2026-07-17T13:31:20.320802Z","end":"2026-07-17T13:31:20.430235Z","steps":["trace[1710804577] 'process raft request' (duration: 109.117927ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:20.430567Z","caller":"traceutil/trace.go:171","msg":"trace[1975549051] transaction","detail":"{read_only:false; response_revision:25235; number_of_response:1; }","duration":"109.26088ms","start":"2026-07-17T13:31:20.321289Z","end":"2026-07-17T13:31:20.43055Z","steps":["trace[1975549051] 'process raft request' (duration: 108.834968ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:20.430983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.840924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:130068"} {"level":"info","ts":"2026-07-17T13:31:20.431077Z","caller":"traceutil/trace.go:171","msg":"trace[1064961839] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:25236; }","duration":"111.005299ms","start":"2026-07-17T13:31:20.32005Z","end":"2026-07-17T13:31:20.431056Z","steps":["trace[1064961839] 'agreement among raft nodes before linearized reading' (duration: 110.67178ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:20.43113Z","caller":"traceutil/trace.go:171","msg":"trace[1506011561] transaction","detail":"{read_only:false; response_revision:25236; number_of_response:1; }","duration":"108.962003ms","start":"2026-07-17T13:31:20.322155Z","end":"2026-07-17T13:31:20.431117Z","steps":["trace[1506011561] 'process raft request' (duration: 108.081068ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:20.445205Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000065ca.wal"} {"level":"info","ts":"2026-07-17T13:31:21.803494Z","caller":"traceutil/trace.go:171","msg":"trace[2112351385] transaction","detail":"{read_only:false; response_revision:25300; number_of_response:1; }","duration":"131.518624ms","start":"2026-07-17T13:31:21.671952Z","end":"2026-07-17T13:31:21.803471Z","steps":["trace[2112351385] 'process raft request' (duration: 131.344789ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:24.052666Z","caller":"traceutil/trace.go:171","msg":"trace[1815413058] transaction","detail":"{read_only:false; response_revision:25320; number_of_response:1; }","duration":"238.47128ms","start":"2026-07-17T13:31:23.814151Z","end":"2026-07-17T13:31:24.052622Z","steps":["trace[1815413058] 'process raft request' (duration: 238.164412ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:24.204663Z","caller":"traceutil/trace.go:171","msg":"trace[1132626896] linearizableReadLoop","detail":"{readStateIndex:26140; appliedIndex:26139; }","duration":"102.264007ms","start":"2026-07-17T13:31:24.102372Z","end":"2026-07-17T13:31:24.204636Z","steps":["trace[1132626896] 'read index received' (duration: 76.315973ms)","trace[1132626896] 'applied index is now lower than readState.Index' (duration: 25.946894ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T13:31:24.204738Z","caller":"traceutil/trace.go:171","msg":"trace[86580673] transaction","detail":"{read_only:false; response_revision:25321; number_of_response:1; }","duration":"144.82261ms","start":"2026-07-17T13:31:24.05986Z","end":"2026-07-17T13:31:24.204682Z","steps":["trace[86580673] 'process raft request' (duration: 118.886485ms)","trace[86580673] 'compare' (duration: 25.746839ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T13:31:24.204882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.491304ms","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-07-17T13:31:24.204929Z","caller":"traceutil/trace.go:171","msg":"trace[1479236143] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25321; }","duration":"102.605937ms","start":"2026-07-17T13:31:24.102309Z","end":"2026-07-17T13:31:24.204915Z","steps":["trace[1479236143] 'agreement among raft nodes before linearized reading' (duration: 102.424502ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:38.009564Z","caller":"traceutil/trace.go:171","msg":"trace[263460382] linearizableReadLoop","detail":"{readStateIndex:26274; appliedIndex:26273; }","duration":"197.78957ms","start":"2026-07-17T13:31:37.81175Z","end":"2026-07-17T13:31:38.009539Z","steps":["trace[263460382] 'read index received' (duration: 132.421118ms)","trace[263460382] 'applied index is now lower than readState.Index' (duration: 65.367251ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T13:31:38.009831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.062717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"} {"level":"info","ts":"2026-07-17T13:31:38.009901Z","caller":"traceutil/trace.go:171","msg":"trace[1193073612] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25451; }","duration":"198.15187ms","start":"2026-07-17T13:31:37.811728Z","end":"2026-07-17T13:31:38.00988Z","steps":["trace[1193073612] 'agreement among raft nodes before linearized reading' (duration: 197.974145ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:38.010126Z","caller":"traceutil/trace.go:171","msg":"trace[495604862] transaction","detail":"{read_only:false; response_revision:25451; number_of_response:1; }","duration":"200.152724ms","start":"2026-07-17T13:31:37.809958Z","end":"2026-07-17T13:31:38.01011Z","steps":["trace[495604862] 'process raft request' (duration: 134.249068ms)","trace[495604862] 'compare' (duration: 64.987561ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T13:31:38.360954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.44472ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-17T13:31:38.361193Z","caller":"traceutil/trace.go:171","msg":"trace[346229305] transaction","detail":"{read_only:false; response_revision:25452; number_of_response:1; }","duration":"335.558815ms","start":"2026-07-17T13:31:38.02559Z","end":"2026-07-17T13:31:38.361148Z","steps":["trace[346229305] 'process raft request' (duration: 190.706184ms)","trace[346229305] 'compare' (duration: 144.06693ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T13:31:38.361345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.838895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-07-17T13:31:38.361376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:31:38.025549Z","time spent":"335.72384ms","remote":"127.0.0.1:33736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":729,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T13:31:38.36139Z","caller":"traceutil/trace.go:171","msg":"trace[439860330] range","detail":"{range_begin:/registry/monitoring.coreos.com/scrapeconfigs/; range_end:/registry/monitoring.coreos.com/scrapeconfigs0; response_count:0; response_revision:25453; }","duration":"240.916727ms","start":"2026-07-17T13:31:38.120457Z","end":"2026-07-17T13:31:38.361373Z","steps":["trace[439860330] 'agreement among raft nodes before linearized reading' (duration: 240.798284ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:38.361218Z","caller":"traceutil/trace.go:171","msg":"trace[839983774] linearizableReadLoop","detail":"{readStateIndex:26276; appliedIndex:26274; }","duration":"240.690611ms","start":"2026-07-17T13:31:38.1205Z","end":"2026-07-17T13:31:38.361191Z","steps":["trace[839983774] 'read index received' (duration: 95.907232ms)","trace[839983774] 'applied index is now lower than readState.Index' (duration: 144.781859ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T13:31:38.361427Z","caller":"traceutil/trace.go:171","msg":"trace[885664269] transaction","detail":"{read_only:false; response_revision:25453; number_of_response:1; }","duration":"243.387946ms","start":"2026-07-17T13:31:38.117985Z","end":"2026-07-17T13:31:38.361373Z","steps":["trace[885664269] 'process raft request' (duration: 243.116719ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:38.427285Z","caller":"traceutil/trace.go:171","msg":"trace[60233843] transaction","detail":"{read_only:false; response_revision:25454; number_of_response:1; }","duration":"171.338631ms","start":"2026-07-17T13:31:38.255918Z","end":"2026-07-17T13:31:38.427257Z","steps":["trace[60233843] 'process raft request' (duration: 171.103034ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:38.427478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.852553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-17T13:31:38.427558Z","caller":"traceutil/trace.go:171","msg":"trace[1715309282] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25454; }","duration":"119.949715ms","start":"2026-07-17T13:31:38.307588Z","end":"2026-07-17T13:31:38.427538Z","steps":["trace[1715309282] 'agreement among raft nodes before linearized reading' (duration: 119.677308ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:38.593409Z","caller":"traceutil/trace.go:171","msg":"trace[552521912] transaction","detail":"{read_only:false; response_revision:25456; number_of_response:1; }","duration":"160.78839ms","start":"2026-07-17T13:31:38.432591Z","end":"2026-07-17T13:31:38.59338Z","steps":["trace[552521912] 'process raft request' (duration: 79.10248ms)","trace[552521912] 'compare' (duration: 81.32581ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T13:31:38.59382Z","caller":"traceutil/trace.go:171","msg":"trace[61751590] transaction","detail":"{read_only:false; response_revision:25457; number_of_response:1; }","duration":"161.128499ms","start":"2026-07-17T13:31:38.432669Z","end":"2026-07-17T13:31:38.593798Z","steps":["trace[61751590] 'process raft request' (duration: 160.653986ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:38.593813Z","caller":"traceutil/trace.go:171","msg":"trace[1210949039] transaction","detail":"{read_only:false; response_revision:25458; number_of_response:1; }","duration":"160.574474ms","start":"2026-07-17T13:31:38.433212Z","end":"2026-07-17T13:31:38.593787Z","steps":["trace[1210949039] 'process raft request' (duration: 160.494551ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:38.767689Z","caller":"traceutil/trace.go:171","msg":"trace[444115668] transaction","detail":"{read_only:false; response_revision:25459; number_of_response:1; }","duration":"117.450156ms","start":"2026-07-17T13:31:38.650209Z","end":"2026-07-17T13:31:38.767659Z","steps":["trace[444115668] 'process raft request' (duration: 117.257641ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:38.947156Z","caller":"traceutil/trace.go:171","msg":"trace[1705936634] transaction","detail":"{read_only:false; response_revision:25460; number_of_response:1; }","duration":"296.822568ms","start":"2026-07-17T13:31:38.650298Z","end":"2026-07-17T13:31:38.947121Z","steps":["trace[1705936634] 'process raft request' (duration: 226.012477ms)","trace[1705936634] 'compare' (duration: 70.458131ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T13:31:38.947467Z","caller":"traceutil/trace.go:171","msg":"trace[1441093890] transaction","detail":"{read_only:false; response_revision:25461; number_of_response:1; }","duration":"293.057305ms","start":"2026-07-17T13:31:38.654377Z","end":"2026-07-17T13:31:38.947434Z","steps":["trace[1441093890] 'process raft request' (duration: 292.636093ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:38.94747Z","caller":"traceutil/trace.go:171","msg":"trace[1158748948] transaction","detail":"{read_only:false; response_revision:25462; number_of_response:1; }","duration":"290.927466ms","start":"2026-07-17T13:31:38.65649Z","end":"2026-07-17T13:31:38.947418Z","steps":["trace[1158748948] 'process raft request' (duration: 290.825833ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:39.184138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.409193ms","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-07-17T13:31:39.184225Z","caller":"traceutil/trace.go:171","msg":"trace[2037123190] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:25462; }","duration":"130.561937ms","start":"2026-07-17T13:31:39.053642Z","end":"2026-07-17T13:31:39.184204Z","steps":["trace[2037123190] 'count revisions from in-memory index tree' (duration: 130.229938ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:31:40.672912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.024852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-17T13:31:40.673024Z","caller":"traceutil/trace.go:171","msg":"trace[1275899953] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:25468; }","duration":"130.223048ms","start":"2026-07-17T13:31:40.542778Z","end":"2026-07-17T13:31:40.673001Z","steps":["trace[1275899953] 'count revisions from in-memory index tree' (duration: 129.855817ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:41.43298Z","caller":"traceutil/trace.go:171","msg":"trace[1712461269] transaction","detail":"{read_only:false; response_revision:25478; number_of_response:1; }","duration":"158.027994ms","start":"2026-07-17T13:31:41.274928Z","end":"2026-07-17T13:31:41.432956Z","steps":["trace[1712461269] 'process raft request' (duration: 157.877049ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:41.441903Z","caller":"traceutil/trace.go:171","msg":"trace[1583377072] transaction","detail":"{read_only:false; response_revision:25479; number_of_response:1; }","duration":"130.794644ms","start":"2026-07-17T13:31:41.311073Z","end":"2026-07-17T13:31:41.441868Z","steps":["trace[1583377072] 'process raft request' (duration: 130.575278ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:41.442092Z","caller":"traceutil/trace.go:171","msg":"trace[214184117] transaction","detail":"{read_only:false; response_revision:25480; number_of_response:1; }","duration":"129.447266ms","start":"2026-07-17T13:31:41.312613Z","end":"2026-07-17T13:31:41.44206Z","steps":["trace[214184117] 'process raft request' (duration: 129.21162ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:45.580089Z","caller":"traceutil/trace.go:171","msg":"trace[1769420485] transaction","detail":"{read_only:false; response_revision:25505; number_of_response:1; }","duration":"132.038388ms","start":"2026-07-17T13:31:45.44802Z","end":"2026-07-17T13:31:45.580058Z","steps":["trace[1769420485] 'process raft request' (duration: 131.704159ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:45.595874Z","caller":"traceutil/trace.go:171","msg":"trace[1164162820] transaction","detail":"{read_only:false; response_revision:25507; number_of_response:1; }","duration":"139.313418ms","start":"2026-07-17T13:31:45.456533Z","end":"2026-07-17T13:31:45.595846Z","steps":["trace[1164162820] 'process raft request' (duration: 139.237776ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:45.596291Z","caller":"traceutil/trace.go:171","msg":"trace[1251382500] transaction","detail":"{read_only:false; response_revision:25506; number_of_response:1; }","duration":"139.813902ms","start":"2026-07-17T13:31:45.456464Z","end":"2026-07-17T13:31:45.596278Z","steps":["trace[1251382500] 'process raft request' (duration: 139.111643ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:50.600455Z","caller":"traceutil/trace.go:171","msg":"trace[181592166] linearizableReadLoop","detail":"{readStateIndex:26377; appliedIndex:26376; }","duration":"111.499162ms","start":"2026-07-17T13:31:50.488925Z","end":"2026-07-17T13:31:50.600424Z","steps":["trace[181592166] 'read index received' (duration: 111.387649ms)","trace[181592166] 'applied index is now lower than readState.Index' (duration: 110.193µs)"],"step_count":2} {"level":"warn","ts":"2026-07-17T13:31:50.60068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.436999ms","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:6"} {"level":"info","ts":"2026-07-17T13:31:50.600742Z","caller":"traceutil/trace.go:171","msg":"trace[1353035319] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:25551; }","duration":"124.615043ms","start":"2026-07-17T13:31:50.476114Z","end":"2026-07-17T13:31:50.600729Z","steps":["trace[1353035319] 'agreement among raft nodes before linearized reading' (duration: 124.442949ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:50.600716Z","caller":"traceutil/trace.go:171","msg":"trace[1676073802] transaction","detail":"{read_only:false; response_revision:25551; number_of_response:1; }","duration":"133.035136ms","start":"2026-07-17T13:31:50.467523Z","end":"2026-07-17T13:31:50.600558Z","steps":["trace[1676073802] 'process raft request' (duration: 132.715117ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:50.601Z","caller":"traceutil/trace.go:171","msg":"trace[906036664] transaction","detail":"{read_only:false; response_revision:25552; number_of_response:1; }","duration":"107.773979ms","start":"2026-07-17T13:31:50.49319Z","end":"2026-07-17T13:31:50.600964Z","steps":["trace[906036664] 'process raft request' (duration: 107.660776ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:52.712427Z","caller":"traceutil/trace.go:171","msg":"trace[493237931] transaction","detail":"{read_only:false; response_revision:25567; number_of_response:1; }","duration":"106.039032ms","start":"2026-07-17T13:31:52.606338Z","end":"2026-07-17T13:31:52.712377Z","steps":["trace[493237931] 'process raft request' (duration: 105.421805ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:31:54.985634Z","caller":"traceutil/trace.go:171","msg":"trace[801166707] transaction","detail":"{read_only:false; response_revision:25585; number_of_response:1; }","duration":"161.18149ms","start":"2026-07-17T13:31:54.82442Z","end":"2026-07-17T13:31:54.985601Z","steps":["trace[801166707] 'process raft request' (duration: 138.123465ms)","trace[801166707] 'compare' (duration: 22.902041ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T13:32:00.015149Z","caller":"traceutil/trace.go:171","msg":"trace[843615241] transaction","detail":"{read_only:false; response_revision:25621; number_of_response:1; }","duration":"273.979649ms","start":"2026-07-17T13:31:59.741127Z","end":"2026-07-17T13:32:00.015106Z","steps":["trace[843615241] 'process raft request' (duration: 232.99939ms)","trace[843615241] 'compare' (duration: 40.419934ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T13:32:00.015153Z","caller":"traceutil/trace.go:171","msg":"trace[1913544026] linearizableReadLoop","detail":"{readStateIndex:26450; appliedIndex:26447; }","duration":"228.601948ms","start":"2026-07-17T13:31:59.786509Z","end":"2026-07-17T13:32:00.015111Z","steps":["trace[1913544026] 'read index received' (duration: 28.492395ms)","trace[1913544026] 'applied index is now lower than readState.Index' (duration: 200.107733ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T13:32:00.015313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.760903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinedeployments/\" range_end:\"/registry/cluster.x-k8s.io/machinedeployments0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-17T13:32:00.015349Z","caller":"traceutil/trace.go:171","msg":"trace[349581662] transaction","detail":"{read_only:false; response_revision:25622; number_of_response:1; }","duration":"271.772818ms","start":"2026-07-17T13:31:59.74356Z","end":"2026-07-17T13:32:00.015333Z","steps":["trace[349581662] 'process raft request' (duration: 271.386578ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:32:00.016257Z","caller":"traceutil/trace.go:171","msg":"trace[1234203331] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinedeployments/; range_end:/registry/cluster.x-k8s.io/machinedeployments0; response_count:0; response_revision:25622; }","duration":"229.72461ms","start":"2026-07-17T13:31:59.786493Z","end":"2026-07-17T13:32:00.016217Z","steps":["trace[1234203331] 'agreement among raft nodes before linearized reading' (duration: 228.669941ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:32:00.80211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.066918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-17T13:32:00.802245Z","caller":"traceutil/trace.go:171","msg":"trace[245908903] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:25623; }","duration":"108.369696ms","start":"2026-07-17T13:32:00.693825Z","end":"2026-07-17T13:32:00.802195Z","steps":["trace[245908903] 'count revisions from in-memory index tree' (duration: 107.953414ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:32:01.127726Z","caller":"traceutil/trace.go:171","msg":"trace[1557747166] transaction","detail":"{read_only:false; response_revision:25626; number_of_response:1; }","duration":"316.415258ms","start":"2026-07-17T13:32:00.811275Z","end":"2026-07-17T13:32:01.12769Z","steps":["trace[1557747166] 'process raft request' (duration: 242.133151ms)","trace[1557747166] 'compare' (duration: 74.059131ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T13:32:01.127921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:32:00.811256Z","time spent":"316.562941ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T13:32:01.128141Z","caller":"traceutil/trace.go:171","msg":"trace[539621511] transaction","detail":"{read_only:false; response_revision:25628; number_of_response:1; }","duration":"316.187602ms","start":"2026-07-17T13:32:00.811925Z","end":"2026-07-17T13:32:01.128112Z","steps":["trace[539621511] 'process raft request' (duration: 316.094079ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:32:01.128229Z","caller":"traceutil/trace.go:171","msg":"trace[1533012319] transaction","detail":"{read_only:false; response_revision:25627; number_of_response:1; }","duration":"316.899541ms","start":"2026-07-17T13:32:00.811296Z","end":"2026-07-17T13:32:01.128195Z","steps":["trace[1533012319] 'process raft request' (duration: 316.349986ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:32:01.12858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:32:00.811271Z","time spent":"317.035555ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T13:32:01.128586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:32:00.811914Z","time spent":"316.361756ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T13:32:01.35407Z","caller":"traceutil/trace.go:171","msg":"trace[1171267088] transaction","detail":"{read_only:false; response_revision:25629; number_of_response:1; }","duration":"410.626914ms","start":"2026-07-17T13:32:00.943397Z","end":"2026-07-17T13:32:01.354024Z","steps":["trace[1171267088] 'process raft request' (duration: 310.989649ms)","trace[1171267088] 'compare' (duration: 99.191152ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T13:32:01.354176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.426265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-17T13:32:01.354206Z","caller":"traceutil/trace.go:171","msg":"trace[1020758093] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddressclaims/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddressclaims0; response_count:0; response_revision:25632; }","duration":"395.500987ms","start":"2026-07-17T13:32:00.958699Z","end":"2026-07-17T13:32:01.3542Z","steps":["trace[1020758093] 'agreement among raft nodes before linearized reading' (duration: 395.427065ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:32:01.354157Z","caller":"traceutil/trace.go:171","msg":"trace[709270248] transaction","detail":"{read_only:false; response_revision:25631; number_of_response:1; }","duration":"323.272616ms","start":"2026-07-17T13:32:01.030811Z","end":"2026-07-17T13:32:01.354083Z","steps":["trace[709270248] 'process raft request' (duration: 323.203204ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:32:01.354231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:32:00.958688Z","time spent":"395.536608ms","remote":"127.0.0.1:60982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":0,"response size":30,"request content":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true "} {"level":"warn","ts":"2026-07-17T13:32:01.354254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:32:00.94337Z","time spent":"410.798218ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T13:32:01.354086Z","caller":"traceutil/trace.go:171","msg":"trace[2071546211] linearizableReadLoop","detail":"{readStateIndex:26457; appliedIndex:26453; }","duration":"395.340952ms","start":"2026-07-17T13:32:00.95873Z","end":"2026-07-17T13:32:01.354071Z","steps":["trace[2071546211] 'read index received' (duration: 94.73341ms)","trace[2071546211] 'applied index is now lower than readState.Index' (duration: 300.606942ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T13:32:01.35426Z","caller":"traceutil/trace.go:171","msg":"trace[1290150140] transaction","detail":"{read_only:false; response_revision:25632; number_of_response:1; }","duration":"322.010812ms","start":"2026-07-17T13:32:01.032197Z","end":"2026-07-17T13:32:01.354208Z","steps":["trace[1290150140] 'process raft request' (duration: 321.845867ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:32:01.354095Z","caller":"traceutil/trace.go:171","msg":"trace[1264270231] transaction","detail":"{read_only:false; response_revision:25630; number_of_response:1; }","duration":"346.573359ms","start":"2026-07-17T13:32:01.007487Z","end":"2026-07-17T13:32:01.354061Z","steps":["trace[1264270231] 'process raft request' (duration: 346.442205ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:32:01.35434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:32:01.030791Z","time spent":"323.450032ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T13:32:01.354441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:32:01.032174Z","time spent":"322.158146ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T13:32:01.354493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.219376ms","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":"warn","ts":"2026-07-17T13:32:01.354478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:32:01.007467Z","time spent":"346.909017ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T13:32:01.354515Z","caller":"traceutil/trace.go:171","msg":"trace[591601003] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:25632; }","duration":"368.241126ms","start":"2026-07-17T13:32:00.986267Z","end":"2026-07-17T13:32:01.354508Z","steps":["trace[591601003] 'agreement among raft nodes before linearized reading' (duration: 368.203215ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:32:01.354529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:32:00.98623Z","time spent":"368.295728ms","remote":"127.0.0.1:46584","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"warn","ts":"2026-07-17T13:32:01.354584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.423535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-17T13:32:01.35462Z","caller":"traceutil/trace.go:171","msg":"trace[1818482959] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25632; }","duration":"362.494057ms","start":"2026-07-17T13:32:00.992115Z","end":"2026-07-17T13:32:01.354609Z","steps":["trace[1818482959] 'agreement among raft nodes before linearized reading' (duration: 362.419595ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:32:01.35465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:32:00.992096Z","time spent":"362.548879ms","remote":"127.0.0.1:33658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-17T13:32:01.3547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.92558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-07-17T13:32:01.35478Z","caller":"traceutil/trace.go:171","msg":"trace[513912629] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25632; }","duration":"318.025412ms","start":"2026-07-17T13:32:01.036731Z","end":"2026-07-17T13:32:01.354757Z","steps":["trace[513912629] 'agreement among raft nodes before linearized reading' (duration: 317.787465ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:32:01.354825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T13:32:01.036725Z","time spent":"318.091704ms","remote":"127.0.0.1:33904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-17T13:32:04.782956Z","caller":"traceutil/trace.go:171","msg":"trace[1474029990] transaction","detail":"{read_only:false; response_revision:25653; number_of_response:1; }","duration":"145.471218ms","start":"2026-07-17T13:32:04.637461Z","end":"2026-07-17T13:32:04.782932Z","steps":["trace[1474029990] 'process raft request' (duration: 145.329774ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:32:05.78743Z","caller":"traceutil/trace.go:171","msg":"trace[1117304846] transaction","detail":"{read_only:false; response_revision:25663; number_of_response:1; }","duration":"176.3886ms","start":"2026-07-17T13:32:05.611017Z","end":"2026-07-17T13:32:05.787406Z","steps":["trace[1117304846] 'process raft request' (duration: 176.264407ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:32:10.26372Z","caller":"traceutil/trace.go:171","msg":"trace[909506080] transaction","detail":"{read_only:false; response_revision:25695; number_of_response:1; }","duration":"193.531762ms","start":"2026-07-17T13:32:10.07016Z","end":"2026-07-17T13:32:10.263692Z","steps":["trace[909506080] 'process raft request' (duration: 163.954348ms)","trace[909506080] 'compare' (duration: 29.462171ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T13:32:13.023615Z","caller":"traceutil/trace.go:171","msg":"trace[115726503] transaction","detail":"{read_only:false; response_revision:25712; number_of_response:1; }","duration":"158.143007ms","start":"2026-07-17T13:32:12.865449Z","end":"2026-07-17T13:32:13.023592Z","steps":["trace[115726503] 'process raft request' (duration: 157.994353ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:32:13.035092Z","caller":"traceutil/trace.go:171","msg":"trace[1173757162] linearizableReadLoop","detail":"{readStateIndex:26544; appliedIndex:26542; }","duration":"160.481802ms","start":"2026-07-17T13:32:12.874587Z","end":"2026-07-17T13:32:13.035069Z","steps":["trace[1173757162] 'read index received' (duration: 148.965304ms)","trace[1173757162] 'applied index is now lower than readState.Index' (duration: 11.515838ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T13:32:13.035162Z","caller":"traceutil/trace.go:171","msg":"trace[1461240219] transaction","detail":"{read_only:false; response_revision:25713; number_of_response:1; }","duration":"168.04113ms","start":"2026-07-17T13:32:12.867093Z","end":"2026-07-17T13:32:13.035134Z","steps":["trace[1461240219] 'process raft request' (duration: 167.821194ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T13:32:13.03522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.609035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-17T13:32:13.035253Z","caller":"traceutil/trace.go:171","msg":"trace[2056416681] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:25713; }","duration":"160.703987ms","start":"2026-07-17T13:32:12.874539Z","end":"2026-07-17T13:32:13.035243Z","steps":["trace[2056416681] 'agreement among raft nodes before linearized reading' (duration: 160.629585ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T13:32:23.628962Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22906} {"level":"info","ts":"2026-07-17T13:32:23.788586Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22906,"took":"155.068182ms","hash":1475562467,"current-db-size-bytes":59035648,"current-db-size":"59 MB","current-db-size-in-use-bytes":36749312,"current-db-size-in-use":"37 MB"} {"level":"info","ts":"2026-07-17T13:32:23.788659Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1475562467,"revision":22906,"compact-revision":20114} {"level":"info","ts":"2026-07-17T13:37:23.634902Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25807} {"level":"info","ts":"2026-07-17T13:37:23.76668Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25807,"took":"127.009904ms","hash":2543546112,"current-db-size-bytes":59035648,"current-db-size":"59 MB","current-db-size-in-use-bytes":38359040,"current-db-size-in-use":"38 MB"} {"level":"info","ts":"2026-07-17T13:37:23.766754Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2543546112,"revision":25807,"compact-revision":22906} {"level":"info","ts":"2026-07-17T13:38:19.100932Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e1254347e028571c","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-17T13:38:19.113703Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-07-17T13:38:19.11385Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-07-17T13:42:23.640574Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28677} {"level":"info","ts":"2026-07-17T13:42:23.77742Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28677,"took":"132.382692ms","hash":3574550984,"current-db-size-bytes":59035648,"current-db-size":"59 MB","current-db-size-in-use-bytes":31182848,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-17T13:42:23.777492Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3574550984,"revision":28677,"compact-revision":25807} {"level":"info","ts":"2026-07-17T13:47:23.647211Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30896} {"level":"info","ts":"2026-07-17T13:47:23.766714Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30896,"took":"114.694423ms","hash":2913667829,"current-db-size-bytes":59035648,"current-db-size":"59 MB","current-db-size-in-use-bytes":31555584,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-07-17T13:47:23.766803Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2913667829,"revision":30896,"compact-revision":28677} {"level":"info","ts":"2026-07-17T13:52:23.653107Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33156} {"level":"info","ts":"2026-07-17T13:52:23.806826Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33156,"took":"148.34612ms","hash":1871077034,"current-db-size-bytes":60080128,"current-db-size":"60 MB","current-db-size-in-use-bytes":31358976,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-17T13:52:23.806987Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1871077034,"revision":33156,"compact-revision":30896} {"level":"info","ts":"2026-07-17T13:57:23.661129Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35456} {"level":"info","ts":"2026-07-17T13:57:23.812372Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35456,"took":"146.18695ms","hash":1825847663,"current-db-size-bytes":61001728,"current-db-size":"61 MB","current-db-size-in-use-bytes":31858688,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-07-17T13:57:23.812453Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1825847663,"revision":35456,"compact-revision":33156} {"level":"info","ts":"2026-07-17T13:59:50.23496Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e1254347e028571c","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-17T13:59:50.239928Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-07-17T13:59:50.240079Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-07-17T14:02:23.670952Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37685} {"level":"info","ts":"2026-07-17T14:02:23.794402Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37685,"took":"118.512898ms","hash":1676083804,"current-db-size-bytes":61423616,"current-db-size":"61 MB","current-db-size-in-use-bytes":33034240,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-07-17T14:02:23.794505Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1676083804,"revision":37685,"compact-revision":35456}