{"level":"warn","ts":"2026-09-01T04:21:17.289455Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-01T04:21:17.289582Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.119:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.119:2380","--initial-cluster=instance=https://162.253.55.119:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.119:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.119: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-09-01T04:21:17.289674Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-01T04:21:17.289694Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.119:2380"]} {"level":"info","ts":"2026-09-01T04:21:17.289721Z","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-09-01T04:21:17.290679Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.119:2379"]} {"level":"info","ts":"2026-09-01T04:21:17.290807Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.119:2380"],"listen-peer-urls":["https://162.253.55.119:2380"],"advertise-client-urls":["https://162.253.55.119:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.119:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.119: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-09-01T04:21:17.294161Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.995807ms"} {"level":"info","ts":"2026-09-01T04:21:17.301277Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2f0e00eb3c3ee1b","cluster-id":"8e467f099f65c603"} {"level":"info","ts":"2026-09-01T04:21:17.301414Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b switched to configuration voters=()"} {"level":"info","ts":"2026-09-01T04:21:17.301451Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b became follower at term 0"} {"level":"info","ts":"2026-09-01T04:21:17.301473Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2f0e00eb3c3ee1b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-01T04:21:17.301493Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b became follower at term 1"} {"level":"info","ts":"2026-09-01T04:21:17.301557Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b switched to configuration voters=(211915536236539419)"} {"level":"warn","ts":"2026-09-01T04:21:17.316894Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-01T04:21:17.31897Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-01T04:21:17.320492Z","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-09-01T04:21:17.323852Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2f0e00eb3c3ee1b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-01T04:21:17.324085Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2f0e00eb3c3ee1b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-01T04:21:17.324348Z","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-09-01T04:21:17.324439Z","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-09-01T04:21:17.32445Z","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-09-01T04:21:17.325612Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b switched to configuration voters=(211915536236539419)"} {"level":"info","ts":"2026-09-01T04:21:17.327281Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8e467f099f65c603","local-member-id":"2f0e00eb3c3ee1b","added-peer-id":"2f0e00eb3c3ee1b","added-peer-peer-urls":["https://162.253.55.119:2380"]} {"level":"info","ts":"2026-09-01T04:21:17.329438Z","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-09-01T04:21:17.329613Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.119:2380"} {"level":"info","ts":"2026-09-01T04:21:17.329685Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.119:2380"} {"level":"info","ts":"2026-09-01T04:21:17.32977Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2f0e00eb3c3ee1b","initial-advertise-peer-urls":["https://162.253.55.119:2380"],"listen-peer-urls":["https://162.253.55.119:2380"],"advertise-client-urls":["https://162.253.55.119:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.119:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-01T04:21:17.329811Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-01T04:21:18.302489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b is starting a new election at term 1"} {"level":"info","ts":"2026-09-01T04:21:18.302569Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b became pre-candidate at term 1"} {"level":"info","ts":"2026-09-01T04:21:18.302604Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b received MsgPreVoteResp from 2f0e00eb3c3ee1b at term 1"} {"level":"info","ts":"2026-09-01T04:21:18.302619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b became candidate at term 2"} {"level":"info","ts":"2026-09-01T04:21:18.302624Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b received MsgVoteResp from 2f0e00eb3c3ee1b at term 2"} {"level":"info","ts":"2026-09-01T04:21:18.302636Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b became leader at term 2"} {"level":"info","ts":"2026-09-01T04:21:18.302646Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2f0e00eb3c3ee1b elected leader 2f0e00eb3c3ee1b at term 2"} {"level":"info","ts":"2026-09-01T04:21:18.303967Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T04:21:18.305193Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2f0e00eb3c3ee1b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.119:2379]}","request-path":"/0/members/2f0e00eb3c3ee1b/attributes","cluster-id":"8e467f099f65c603","publish-timeout":"7s"} {"level":"info","ts":"2026-09-01T04:21:18.305206Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-01T04:21:18.305396Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-01T04:21:18.305655Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-01T04:21:18.305771Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-01T04:21:18.307885Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-01T04:21:18.30893Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.119:2379"} {"level":"info","ts":"2026-09-01T04:21:18.319708Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8e467f099f65c603","local-member-id":"2f0e00eb3c3ee1b","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T04:21:18.319847Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T04:21:18.319884Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T04:22:05.113934Z","caller":"traceutil/trace.go:171","msg":"trace[1303123298] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"256.317434ms","start":"2026-09-01T04:22:04.857594Z","end":"2026-09-01T04:22:05.113911Z","steps":["trace[1303123298] 'process raft request' (duration: 254.052816ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:22:05.731088Z","caller":"traceutil/trace.go:171","msg":"trace[1413790135] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:620; }","duration":"127.887718ms","start":"2026-09-01T04:22:05.603182Z","end":"2026-09-01T04:22:05.731069Z","steps":["trace[1413790135] 'read index received' (duration: 127.737874ms)","trace[1413790135] 'applied index is now lower than readState.Index' (duration: 149.034µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:22:05.731179Z","caller":"traceutil/trace.go:171","msg":"trace[781082968] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"541.177229ms","start":"2026-09-01T04:22:05.189992Z","end":"2026-09-01T04:22:05.731169Z","steps":["trace[781082968] 'process raft request' (duration: 540.975393ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:22:05.731726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:22:05.189964Z","time spent":"541.315524ms","remote":"127.0.0.1:44984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1044,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-01T04:22:05.73189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.656642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-kgb6n\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-01T04:22:05.732029Z","caller":"traceutil/trace.go:171","msg":"trace[797902804] range","detail":"{range_begin:/registry/pods/kube-system/cilium-kgb6n; range_end:; response_count:1; response_revision:592; }","duration":"128.875459ms","start":"2026-09-01T04:22:05.603129Z","end":"2026-09-01T04:22:05.732004Z","steps":["trace[797902804] 'agreement among raft nodes before linearized reading' (duration: 128.181038ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:22:06.402714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.688211ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T04:22:06.402899Z","caller":"traceutil/trace.go:171","msg":"trace[659375512] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:621; }","duration":"658.8451ms","start":"2026-09-01T04:22:05.744042Z","end":"2026-09-01T04:22:06.402887Z","steps":["trace[659375512] 'read index received' (duration: 21.185629ms)","trace[659375512] 'applied index is now lower than readState.Index' (duration: 637.658831ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:22:06.403082Z","caller":"traceutil/trace.go:171","msg":"trace[1111498301] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"651.920011ms","start":"2026-09-01T04:22:05.751141Z","end":"2026-09-01T04:22:06.403062Z","steps":["trace[1111498301] 'process raft request' (duration: 651.653353ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:22:06.40314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:22:05.751091Z","time spent":"652.016393ms","remote":"127.0.0.1:44836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T04:22:06.403152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.101257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:22:06.403166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.699326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-09-01T04:22:06.403179Z","caller":"traceutil/trace.go:171","msg":"trace[43921656] range","detail":"{range_begin:/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system; range_end:; response_count:0; response_revision:595; }","duration":"659.152929ms","start":"2026-09-01T04:22:05.744018Z","end":"2026-09-01T04:22:06.403171Z","steps":["trace[43921656] 'agreement among raft nodes before linearized reading' (duration: 659.105238ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:22:06.403185Z","caller":"traceutil/trace.go:171","msg":"trace[990735672] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:595; }","duration":"316.750428ms","start":"2026-09-01T04:22:06.086429Z","end":"2026-09-01T04:22:06.403179Z","steps":["trace[990735672] 'agreement among raft nodes before linearized reading' (duration: 316.667415ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:22:06.403195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:22:05.74401Z","time spent":"659.18136ms","remote":"127.0.0.1:44996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" "} {"level":"warn","ts":"2026-09-01T04:22:06.4032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:22:06.086385Z","time spent":"316.811619ms","remote":"127.0.0.1:44920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-01T04:22:06.403393Z","caller":"traceutil/trace.go:171","msg":"trace[1687111956] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"665.378118ms","start":"2026-09-01T04:22:05.738Z","end":"2026-09-01T04:22:06.403378Z","steps":["trace[1687111956] 'process raft request' (duration: 428.657395ms)","trace[1687111956] 'compare' (duration: 235.416003ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:22:06.403477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:22:05.737973Z","time spent":"665.48365ms","remote":"127.0.0.1:44920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T04:22:22.584311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.364379ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T04:22:22.58448Z","caller":"traceutil/trace.go:171","msg":"trace[851840255] linearizableReadLoop","detail":"{readStateIndex:799; appliedIndex:798; }","duration":"230.583097ms","start":"2026-09-01T04:22:22.353878Z","end":"2026-09-01T04:22:22.584461Z","steps":["trace[851840255] 'read index received' (duration: 10.983491ms)","trace[851840255] 'applied index is now lower than readState.Index' (duration: 219.597646ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:22:22.584528Z","caller":"traceutil/trace.go:171","msg":"trace[1534837473] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"382.238704ms","start":"2026-09-01T04:22:22.202246Z","end":"2026-09-01T04:22:22.584485Z","steps":["trace[1534837473] 'process raft request' (duration: 162.587506ms)","trace[1534837473] 'compare' (duration: 218.951907ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:22:22.584611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.703202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:22:22.584708Z","caller":"traceutil/trace.go:171","msg":"trace[1798787056] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:765; }","duration":"230.851396ms","start":"2026-09-01T04:22:22.353837Z","end":"2026-09-01T04:22:22.584689Z","steps":["trace[1798787056] 'agreement among raft nodes before linearized reading' (duration: 230.705201ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:22:22.58478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:22:22.20223Z","time spent":"382.407918ms","remote":"127.0.0.1:44920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T04:22:50.918225Z","caller":"traceutil/trace.go:171","msg":"trace[960557613] linearizableReadLoop","detail":"{readStateIndex:1198; appliedIndex:1197; }","duration":"156.171972ms","start":"2026-09-01T04:22:50.762036Z","end":"2026-09-01T04:22:50.918207Z","steps":["trace[960557613] 'read index received' (duration: 156.013597ms)","trace[960557613] 'applied index is now lower than readState.Index' (duration: 157.775µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:22:50.918286Z","caller":"traceutil/trace.go:171","msg":"trace[1111141865] transaction","detail":"{read_only:false; response_revision:1158; number_of_response:1; }","duration":"173.691701ms","start":"2026-09-01T04:22:50.744564Z","end":"2026-09-01T04:22:50.918256Z","steps":["trace[1111141865] 'process raft request' (duration: 173.542897ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:22:50.918382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.339588ms","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-09-01T04:22:50.918425Z","caller":"traceutil/trace.go:171","msg":"trace[1044027070] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1158; }","duration":"156.43384ms","start":"2026-09-01T04:22:50.761984Z","end":"2026-09-01T04:22:50.918418Z","steps":["trace[1044027070] 'agreement among raft nodes before linearized reading' (duration: 156.311987ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:22:50.918668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.566508ms","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-09-01T04:22:50.918722Z","caller":"traceutil/trace.go:171","msg":"trace[1992797834] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1158; }","duration":"125.669162ms","start":"2026-09-01T04:22:50.793039Z","end":"2026-09-01T04:22:50.918708Z","steps":["trace[1992797834] 'agreement among raft nodes before linearized reading' (duration: 125.533108ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:23:13.166681Z","caller":"traceutil/trace.go:171","msg":"trace[716056997] linearizableReadLoop","detail":"{readStateIndex:1466; appliedIndex:1465; }","duration":"131.623636ms","start":"2026-09-01T04:23:13.035025Z","end":"2026-09-01T04:23:13.166649Z","steps":["trace[716056997] 'read index received' (duration: 131.317016ms)","trace[716056997] 'applied index is now lower than readState.Index' (duration: 305.369µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:23:13.166799Z","caller":"traceutil/trace.go:171","msg":"trace[217947400] transaction","detail":"{read_only:false; response_revision:1417; number_of_response:1; }","duration":"133.934994ms","start":"2026-09-01T04:23:13.032808Z","end":"2026-09-01T04:23:13.166743Z","steps":["trace[217947400] 'process raft request' (duration: 133.645156ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:23:13.16709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.501271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-09-01T04:23:13.167132Z","caller":"traceutil/trace.go:171","msg":"trace[1790880985] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1417; }","duration":"131.596725ms","start":"2026-09-01T04:23:13.035523Z","end":"2026-09-01T04:23:13.16712Z","steps":["trace[1790880985] 'agreement among raft nodes before linearized reading' (duration: 131.321886ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:23:13.167481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.429309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-09-01T04:23:13.167681Z","caller":"traceutil/trace.go:171","msg":"trace[745174729] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1417; }","duration":"132.686227ms","start":"2026-09-01T04:23:13.034973Z","end":"2026-09-01T04:23:13.167659Z","steps":["trace[745174729] 'agreement among raft nodes before linearized reading' (duration: 131.826401ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:23:38.024281Z","caller":"traceutil/trace.go:171","msg":"trace[255583657] linearizableReadLoop","detail":"{readStateIndex:1917; appliedIndex:1916; }","duration":"133.980305ms","start":"2026-09-01T04:23:37.890279Z","end":"2026-09-01T04:23:38.02426Z","steps":["trace[255583657] 'read index received' (duration: 133.912893ms)","trace[255583657] 'applied index is now lower than readState.Index' (duration: 66.832µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:23:38.02439Z","caller":"traceutil/trace.go:171","msg":"trace[54161822] transaction","detail":"{read_only:false; response_revision:1841; number_of_response:1; }","duration":"191.278765ms","start":"2026-09-01T04:23:37.833061Z","end":"2026-09-01T04:23:38.02434Z","steps":["trace[54161822] 'process raft request' (duration: 191.087709ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:23:38.024443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.156831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:23:38.024471Z","caller":"traceutil/trace.go:171","msg":"trace[1482644024] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1841; }","duration":"134.299845ms","start":"2026-09-01T04:23:37.890163Z","end":"2026-09-01T04:23:38.024463Z","steps":["trace[1482644024] 'agreement among raft nodes before linearized reading' (duration: 134.188902ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:23:38.183462Z","caller":"traceutil/trace.go:171","msg":"trace[1083790402] transaction","detail":"{read_only:false; response_revision:1842; number_of_response:1; }","duration":"136.311255ms","start":"2026-09-01T04:23:38.047123Z","end":"2026-09-01T04:23:38.183434Z","steps":["trace[1083790402] 'process raft request' (duration: 136.065507ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:23:38.487403Z","caller":"traceutil/trace.go:171","msg":"trace[1869912363] linearizableReadLoop","detail":"{readStateIndex:1919; appliedIndex:1918; }","duration":"163.016652ms","start":"2026-09-01T04:23:38.324338Z","end":"2026-09-01T04:23:38.487355Z","steps":["trace[1869912363] 'read index received' (duration: 142.354316ms)","trace[1869912363] 'applied index is now lower than readState.Index' (duration: 20.661326ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:23:38.487437Z","caller":"traceutil/trace.go:171","msg":"trace[467614458] transaction","detail":"{read_only:false; response_revision:1843; number_of_response:1; }","duration":"170.202166ms","start":"2026-09-01T04:23:38.317191Z","end":"2026-09-01T04:23:38.487393Z","steps":["trace[467614458] 'process raft request' (duration: 149.54231ms)","trace[467614458] 'compare' (duration: 20.4488ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:23:38.4876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.238128ms","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-09-01T04:23:38.487643Z","caller":"traceutil/trace.go:171","msg":"trace[623992232] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1843; }","duration":"163.325621ms","start":"2026-09-01T04:23:38.324302Z","end":"2026-09-01T04:23:38.487628Z","steps":["trace[623992232] 'agreement among raft nodes before linearized reading' (duration: 163.171886ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:24:27.820722Z","caller":"traceutil/trace.go:171","msg":"trace[616521197] transaction","detail":"{read_only:false; response_revision:2158; number_of_response:1; }","duration":"253.396535ms","start":"2026-09-01T04:24:27.567295Z","end":"2026-09-01T04:24:27.820691Z","steps":["trace[616521197] 'process raft request' (duration: 155.297443ms)","trace[616521197] 'compare' (duration: 97.895346ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:24:27.820884Z","caller":"traceutil/trace.go:171","msg":"trace[1538860865] transaction","detail":"{read_only:false; response_revision:2159; number_of_response:1; }","duration":"228.517819ms","start":"2026-09-01T04:24:27.592351Z","end":"2026-09-01T04:24:27.820869Z","steps":["trace[1538860865] 'process raft request' (duration: 228.284043ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:24:27.820886Z","caller":"traceutil/trace.go:171","msg":"trace[723674025] linearizableReadLoop","detail":"{readStateIndex:2245; appliedIndex:2243; }","duration":"228.413866ms","start":"2026-09-01T04:24:27.592421Z","end":"2026-09-01T04:24:27.820835Z","steps":["trace[723674025] 'read index received' (duration: 130.16322ms)","trace[723674025] 'applied index is now lower than readState.Index' (duration: 98.241326ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:24:27.821071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.635253ms","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":"warn","ts":"2026-09-01T04:24:27.821103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.070397ms","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-09-01T04:24:27.821137Z","caller":"traceutil/trace.go:171","msg":"trace[1970634738] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2159; }","duration":"228.756646ms","start":"2026-09-01T04:24:27.592366Z","end":"2026-09-01T04:24:27.821123Z","steps":["trace[1970634738] 'agreement among raft nodes before linearized reading' (duration: 228.563871ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:24:27.821131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.520779ms","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-09-01T04:24:27.821165Z","caller":"traceutil/trace.go:171","msg":"trace[2069625308] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2159; }","duration":"228.159629ms","start":"2026-09-01T04:24:27.59299Z","end":"2026-09-01T04:24:27.82115Z","steps":["trace[2069625308] 'agreement among raft nodes before linearized reading' (duration: 228.000595ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:24:27.821184Z","caller":"traceutil/trace.go:171","msg":"trace[1882882982] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2159; }","duration":"186.605072ms","start":"2026-09-01T04:24:27.634562Z","end":"2026-09-01T04:24:27.821167Z","steps":["trace[1882882982] 'agreement among raft nodes before linearized reading' (duration: 186.431957ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:24:27.821257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.962775ms","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-09-01T04:24:27.821306Z","caller":"traceutil/trace.go:171","msg":"trace[161553056] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2159; }","duration":"191.045897ms","start":"2026-09-01T04:24:27.630246Z","end":"2026-09-01T04:24:27.821292Z","steps":["trace[161553056] 'agreement among raft nodes before linearized reading' (duration: 190.922604ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:24:34.167128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.24761ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T04:24:34.1673Z","caller":"traceutil/trace.go:171","msg":"trace[1345860074] linearizableReadLoop","detail":"{readStateIndex:2279; appliedIndex:2278; }","duration":"218.675079ms","start":"2026-09-01T04:24:33.9486Z","end":"2026-09-01T04:24:34.167275Z","steps":["trace[1345860074] 'read index received' (duration: 117.118901ms)","trace[1345860074] 'applied index is now lower than readState.Index' (duration: 101.553788ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:24:34.167383Z","caller":"traceutil/trace.go:171","msg":"trace[1127071481] transaction","detail":"{read_only:false; response_revision:2191; number_of_response:1; }","duration":"320.908679ms","start":"2026-09-01T04:24:33.846448Z","end":"2026-09-01T04:24:34.167357Z","steps":["trace[1127071481] 'process raft request' (duration: 219.322529ms)","trace[1127071481] 'compare' (duration: 101.041694ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:24:34.167493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:24:33.846417Z","time spent":"321.020231ms","remote":"127.0.0.1:44920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T04:24:34.167584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.816141ms","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-09-01T04:24:34.167623Z","caller":"traceutil/trace.go:171","msg":"trace[1612434650] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2191; }","duration":"195.893494ms","start":"2026-09-01T04:24:33.971716Z","end":"2026-09-01T04:24:34.16761Z","steps":["trace[1612434650] 'agreement among raft nodes before linearized reading' (duration: 195.725379ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:24:34.167599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.983169ms","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-09-01T04:24:34.167695Z","caller":"traceutil/trace.go:171","msg":"trace[2136680709] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2191; }","duration":"219.131103ms","start":"2026-09-01T04:24:33.94854Z","end":"2026-09-01T04:24:34.167671Z","steps":["trace[2136680709] 'agreement among raft nodes before linearized reading' (duration: 218.863825ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:24:34.167843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.804653ms","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-09-01T04:24:34.167919Z","caller":"traceutil/trace.go:171","msg":"trace[1861417] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2191; }","duration":"194.916526ms","start":"2026-09-01T04:24:33.972982Z","end":"2026-09-01T04:24:34.167899Z","steps":["trace[1861417] 'agreement among raft nodes before linearized reading' (duration: 194.736801ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:24:34.169811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.692295ms","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-09-01T04:24:34.169916Z","caller":"traceutil/trace.go:171","msg":"trace[362523140] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2191; }","duration":"197.815088ms","start":"2026-09-01T04:24:33.972056Z","end":"2026-09-01T04:24:34.169871Z","steps":["trace[362523140] 'agreement among raft nodes before linearized reading' (duration: 195.903304ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:24:34.507005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.458037ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T04:24:34.50733Z","caller":"traceutil/trace.go:171","msg":"trace[1315086573] transaction","detail":"{read_only:false; response_revision:2192; number_of_response:1; }","duration":"331.271563ms","start":"2026-09-01T04:24:34.176018Z","end":"2026-09-01T04:24:34.50729Z","steps":["trace[1315086573] 'process raft request' (duration: 132.435975ms)","trace[1315086573] 'compare' (duration: 198.338124ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:24:34.507429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:24:34.175995Z","time spent":"331.408916ms","remote":"127.0.0.1:44920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T04:24:34.546544Z","caller":"traceutil/trace.go:171","msg":"trace[1726967450] transaction","detail":"{read_only:false; response_revision:2193; number_of_response:1; }","duration":"370.372221ms","start":"2026-09-01T04:24:34.176147Z","end":"2026-09-01T04:24:34.546519Z","steps":["trace[1726967450] 'process raft request' (duration: 370.148245ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:24:34.546869Z","caller":"traceutil/trace.go:171","msg":"trace[1914535808] transaction","detail":"{read_only:false; response_revision:2194; number_of_response:1; }","duration":"370.702861ms","start":"2026-09-01T04:24:34.176147Z","end":"2026-09-01T04:24:34.54685Z","steps":["trace[1914535808] 'process raft request' (duration: 370.33386ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:24:34.546882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:24:34.176128Z","time spent":"370.491895ms","remote":"127.0.0.1:44920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T04:24:34.546968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:24:34.176137Z","time spent":"370.778862ms","remote":"127.0.0.1:44920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T04:24:34.547172Z","caller":"traceutil/trace.go:171","msg":"trace[1388387816] linearizableReadLoop","detail":"{readStateIndex:2284; appliedIndex:2280; }","duration":"181.368602ms","start":"2026-09-01T04:24:34.365784Z","end":"2026-09-01T04:24:34.547152Z","steps":["trace[1388387816] 'read index received' (duration: 180.445576ms)","trace[1388387816] 'applied index is now lower than readState.Index' (duration: 922.146µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:24:34.547261Z","caller":"traceutil/trace.go:171","msg":"trace[412205975] transaction","detail":"{read_only:false; response_revision:2196; number_of_response:1; }","duration":"246.53153ms","start":"2026-09-01T04:24:34.300685Z","end":"2026-09-01T04:24:34.547216Z","steps":["trace[412205975] 'process raft request' (duration: 246.380136ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:24:34.54725Z","caller":"traceutil/trace.go:171","msg":"trace[2004703753] transaction","detail":"{read_only:false; response_revision:2195; number_of_response:1; }","duration":"370.985729ms","start":"2026-09-01T04:24:34.176223Z","end":"2026-09-01T04:24:34.547209Z","steps":["trace[2004703753] 'process raft request' (duration: 370.570837ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:24:34.547332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.527217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-01T04:24:34.547493Z","caller":"traceutil/trace.go:171","msg":"trace[369753728] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:2196; }","duration":"181.760403ms","start":"2026-09-01T04:24:34.365718Z","end":"2026-09-01T04:24:34.547478Z","steps":["trace[369753728] 'agreement among raft nodes before linearized reading' (duration: 181.547037ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:24:34.547575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:24:34.176192Z","time spent":"371.178124ms","remote":"127.0.0.1:44920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T04:25:09.023866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.658715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:25:09.023944Z","caller":"traceutil/trace.go:171","msg":"trace[1452456784] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2557; }","duration":"215.779919ms","start":"2026-09-01T04:25:08.808147Z","end":"2026-09-01T04:25:09.023927Z","steps":["trace[1452456784] 'range keys from in-memory index tree' (duration: 215.563412ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:25:09.024279Z","caller":"traceutil/trace.go:171","msg":"trace[1287467840] linearizableReadLoop","detail":"{readStateIndex:2660; appliedIndex:2659; }","duration":"133.406313ms","start":"2026-09-01T04:25:08.890823Z","end":"2026-09-01T04:25:09.024229Z","steps":["trace[1287467840] 'read index received' (duration: 117.983466ms)","trace[1287467840] 'applied index is now lower than readState.Index' (duration: 15.421717ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:25:09.024388Z","caller":"traceutil/trace.go:171","msg":"trace[1660422925] transaction","detail":"{read_only:false; response_revision:2558; number_of_response:1; }","duration":"159.534034ms","start":"2026-09-01T04:25:08.864833Z","end":"2026-09-01T04:25:09.024367Z","steps":["trace[1660422925] 'process raft request' (duration: 143.945912ms)","trace[1660422925] 'compare' (duration: 14.777679ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:25:09.024465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.634709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-09-01T04:25:09.024505Z","caller":"traceutil/trace.go:171","msg":"trace[593194077] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2558; }","duration":"133.712342ms","start":"2026-09-01T04:25:08.890782Z","end":"2026-09-01T04:25:09.024494Z","steps":["trace[593194077] 'agreement among raft nodes before linearized reading' (duration: 133.565478ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:25:42.658794Z","caller":"traceutil/trace.go:171","msg":"trace[1626259830] transaction","detail":"{read_only:false; response_revision:2759; number_of_response:1; }","duration":"207.336792ms","start":"2026-09-01T04:25:42.451428Z","end":"2026-09-01T04:25:42.658765Z","steps":["trace[1626259830] 'process raft request' (duration: 156.03831ms)","trace[1626259830] 'compare' (duration: 51.183298ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:28:17.182166Z","caller":"traceutil/trace.go:171","msg":"trace[1458158317] linearizableReadLoop","detail":"{readStateIndex:3840; appliedIndex:3838; }","duration":"111.553877ms","start":"2026-09-01T04:28:17.070582Z","end":"2026-09-01T04:28:17.182136Z","steps":["trace[1458158317] 'read index received' (duration: 67.83175ms)","trace[1458158317] 'applied index is now lower than readState.Index' (duration: 43.720807ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:28:17.182561Z","caller":"traceutil/trace.go:171","msg":"trace[665297287] transaction","detail":"{read_only:false; response_revision:3693; number_of_response:1; }","duration":"112.839936ms","start":"2026-09-01T04:28:17.069663Z","end":"2026-09-01T04:28:17.182503Z","steps":["trace[665297287] 'process raft request' (duration: 109.219335ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:28:17.182703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.079883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/secretexports.secretgen.carvel.dev\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:28:17.182799Z","caller":"traceutil/trace.go:171","msg":"trace[1609382310] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/secretexports.secretgen.carvel.dev; range_end:; response_count:0; response_revision:3693; }","duration":"112.243528ms","start":"2026-09-01T04:28:17.070533Z","end":"2026-09-01T04:28:17.182777Z","steps":["trace[1609382310] 'agreement among raft nodes before linearized reading' (duration: 111.965599ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:30:19.545588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.986955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-01T04:30:19.54568Z","caller":"traceutil/trace.go:171","msg":"trace[1291709645] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:5143; }","duration":"171.105309ms","start":"2026-09-01T04:30:19.374557Z","end":"2026-09-01T04:30:19.545663Z","steps":["trace[1291709645] 'count revisions from in-memory index tree' (duration: 170.928023ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:30:19.545715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.271838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:30:19.545768Z","caller":"traceutil/trace.go:171","msg":"trace[1678136463] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:5143; }","duration":"101.359751ms","start":"2026-09-01T04:30:19.444389Z","end":"2026-09-01T04:30:19.545749Z","steps":["trace[1678136463] 'count revisions from in-memory index tree' (duration: 101.203495ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:30:19.546116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.20004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4c89721e-0fff-4304-b152-066aca6466be\" ","response":"range_response_count:1 size:3721"} {"level":"info","ts":"2026-09-01T04:30:19.546151Z","caller":"traceutil/trace.go:171","msg":"trace[1575784337] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4c89721e-0fff-4304-b152-066aca6466be; range_end:; response_count:1; response_revision:5143; }","duration":"267.262002ms","start":"2026-09-01T04:30:19.278879Z","end":"2026-09-01T04:30:19.54614Z","steps":["trace[1575784337] 'range keys from in-memory index tree' (duration: 267.142618ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:30:23.346302Z","caller":"traceutil/trace.go:171","msg":"trace[1380780726] transaction","detail":"{read_only:false; response_revision:5235; number_of_response:1; }","duration":"101.619209ms","start":"2026-09-01T04:30:23.244644Z","end":"2026-09-01T04:30:23.346263Z","steps":["trace[1380780726] 'process raft request' (duration: 22.80103ms)","trace[1380780726] 'compare' (duration: 78.662584ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:30:32.722759Z","caller":"traceutil/trace.go:171","msg":"trace[1633225939] transaction","detail":"{read_only:false; response_revision:5404; number_of_response:1; }","duration":"107.147229ms","start":"2026-09-01T04:30:32.615592Z","end":"2026-09-01T04:30:32.72274Z","steps":["trace[1633225939] 'process raft request' (duration: 96.520285ms)","trace[1633225939] 'compare' (duration: 10.52294ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:30:32.921062Z","caller":"traceutil/trace.go:171","msg":"trace[25435477] linearizableReadLoop","detail":"{readStateIndex:5614; appliedIndex:5612; }","duration":"113.463765ms","start":"2026-09-01T04:30:32.807559Z","end":"2026-09-01T04:30:32.921023Z","steps":["trace[25435477] 'read index received' (duration: 28.894609ms)","trace[25435477] 'applied index is now lower than readState.Index' (duration: 84.568086ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:30:32.921367Z","caller":"traceutil/trace.go:171","msg":"trace[1229169991] transaction","detail":"{read_only:false; response_revision:5406; number_of_response:1; }","duration":"162.284847ms","start":"2026-09-01T04:30:32.759031Z","end":"2026-09-01T04:30:32.921316Z","steps":["trace[1229169991] 'process raft request' (duration: 77.428781ms)","trace[1229169991] 'compare' (duration: 84.305157ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:30:32.921465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.87422ms","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-09-01T04:30:32.921522Z","caller":"traceutil/trace.go:171","msg":"trace[984172761] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5407; }","duration":"113.992703ms","start":"2026-09-01T04:30:32.807514Z","end":"2026-09-01T04:30:32.921507Z","steps":["trace[984172761] 'agreement among raft nodes before linearized reading' (duration: 113.721764ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:30:32.921535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.718824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:30:32.92162Z","caller":"traceutil/trace.go:171","msg":"trace[1651178565] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5407; }","duration":"113.781986ms","start":"2026-09-01T04:30:32.807807Z","end":"2026-09-01T04:30:32.921589Z","steps":["trace[1651178565] 'agreement among raft nodes before linearized reading' (duration: 113.678513ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:30:32.921946Z","caller":"traceutil/trace.go:171","msg":"trace[786718338] transaction","detail":"{read_only:false; response_revision:5407; number_of_response:1; }","duration":"162.889488ms","start":"2026-09-01T04:30:32.759044Z","end":"2026-09-01T04:30:32.921933Z","steps":["trace[786718338] 'process raft request' (duration: 161.929645ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:30:33.368874Z","caller":"traceutil/trace.go:171","msg":"trace[1751037350] transaction","detail":"{read_only:false; response_revision:5409; number_of_response:1; }","duration":"145.225603ms","start":"2026-09-01T04:30:33.223607Z","end":"2026-09-01T04:30:33.368833Z","steps":["trace[1751037350] 'process raft request' (duration: 145.031976ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:30:33.369731Z","caller":"traceutil/trace.go:171","msg":"trace[1420317034] transaction","detail":"{read_only:false; response_revision:5410; number_of_response:1; }","duration":"136.393991ms","start":"2026-09-01T04:30:33.233314Z","end":"2026-09-01T04:30:33.369708Z","steps":["trace[1420317034] 'process raft request' (duration: 136.271717ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:30:42.548614Z","caller":"traceutil/trace.go:171","msg":"trace[896971145] transaction","detail":"{read_only:false; response_revision:5586; number_of_response:1; }","duration":"131.892596ms","start":"2026-09-01T04:30:42.416659Z","end":"2026-09-01T04:30:42.548552Z","steps":["trace[896971145] 'process raft request' (duration: 37.191733ms)","trace[896971145] 'compare' (duration: 94.548628ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:30:43.02112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.234055ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T04:30:43.021269Z","caller":"traceutil/trace.go:171","msg":"trace[1446435088] transaction","detail":"{read_only:false; response_revision:5587; number_of_response:1; }","duration":"468.276904ms","start":"2026-09-01T04:30:42.552964Z","end":"2026-09-01T04:30:43.021241Z","steps":["trace[1446435088] 'process raft request' (duration: 121.630915ms)","trace[1446435088] 'compare' (duration: 346.039268ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:30:43.021354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:30:42.552899Z","time spent":"468.409798ms","remote":"127.0.0.1:44920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T04:30:43.067801Z","caller":"traceutil/trace.go:171","msg":"trace[1012057953] linearizableReadLoop","detail":"{readStateIndex:5799; appliedIndex:5797; }","duration":"478.241005ms","start":"2026-09-01T04:30:42.589527Z","end":"2026-09-01T04:30:43.067768Z","steps":["trace[1012057953] 'read index received' (duration: 85.149976ms)","trace[1012057953] 'applied index is now lower than readState.Index' (duration: 393.089939ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:30:43.067871Z","caller":"traceutil/trace.go:171","msg":"trace[580004352] transaction","detail":"{read_only:false; response_revision:5588; number_of_response:1; }","duration":"501.103918ms","start":"2026-09-01T04:30:42.566738Z","end":"2026-09-01T04:30:43.067842Z","steps":["trace[580004352] 'process raft request' (duration: 500.777626ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:30:43.067973Z","caller":"traceutil/trace.go:171","msg":"trace[483002750] transaction","detail":"{read_only:false; response_revision:5589; number_of_response:1; }","duration":"396.259478ms","start":"2026-09-01T04:30:42.671654Z","end":"2026-09-01T04:30:43.067913Z","steps":["trace[483002750] 'process raft request' (duration: 396.055531ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:30:43.068101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.558446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-09-01T04:30:43.068121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:30:42.671632Z","time spent":"396.401963ms","remote":"127.0.0.1:44920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T04:30:43.068163Z","caller":"traceutil/trace.go:171","msg":"trace[207256239] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5589; }","duration":"478.66777ms","start":"2026-09-01T04:30:42.589479Z","end":"2026-09-01T04:30:43.068146Z","steps":["trace[207256239] 'agreement among raft nodes before linearized reading' (duration: 478.484904ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:30:43.068137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:30:42.566714Z","time spent":"501.313605ms","remote":"127.0.0.1:44920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T04:30:43.068213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:30:42.589456Z","time spent":"478.744052ms","remote":"127.0.0.1:44920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-01T04:30:43.068292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.164913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-09-01T04:30:43.06836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.133267ms","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-09-01T04:30:43.068384Z","caller":"traceutil/trace.go:171","msg":"trace[2090471105] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:5589; }","duration":"115.358861ms","start":"2026-09-01T04:30:42.953007Z","end":"2026-09-01T04:30:43.068366Z","steps":["trace[2090471105] 'agreement among raft nodes before linearized reading' (duration: 115.098942ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:30:43.068432Z","caller":"traceutil/trace.go:171","msg":"trace[862445974] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5589; }","duration":"437.242631ms","start":"2026-09-01T04:30:42.631171Z","end":"2026-09-01T04:30:43.068413Z","steps":["trace[862445974] 'agreement among raft nodes before linearized reading' (duration: 437.102616ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:30:43.06844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.353718ms","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-09-01T04:30:43.068483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:30:42.631145Z","time spent":"437.324514ms","remote":"127.0.0.1:44920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-09-01T04:30:43.06855Z","caller":"traceutil/trace.go:171","msg":"trace[2131742929] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5589; }","duration":"414.512973ms","start":"2026-09-01T04:30:42.65401Z","end":"2026-09-01T04:30:43.068523Z","steps":["trace[2131742929] 'agreement among raft nodes before linearized reading' (duration: 414.178031ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:30:43.068608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:30:42.653992Z","time spent":"414.604566ms","remote":"127.0.0.1:44920","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-09-01T04:30:43.06862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.849432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-mhgpf\" ","response":"range_response_count:1 size:6445"} {"level":"info","ts":"2026-09-01T04:30:43.068856Z","caller":"traceutil/trace.go:171","msg":"trace[846206514] range","detail":"{range_begin:/registry/pods/openstack/keepalived-mhgpf; range_end:; response_count:1; response_revision:5589; }","duration":"477.990066ms","start":"2026-09-01T04:30:42.590655Z","end":"2026-09-01T04:30:43.068645Z","steps":["trace[846206514] 'agreement among raft nodes before linearized reading' (duration: 477.492269ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:30:43.068888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:30:42.590645Z","time spent":"478.234925ms","remote":"127.0.0.1:44836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6468,"request content":"key:\"/registry/pods/openstack/keepalived-mhgpf\" "} {"level":"info","ts":"2026-09-01T04:31:18.339032Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2956} {"level":"info","ts":"2026-09-01T04:31:18.42554Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2956,"took":"84.952946ms","hash":2340909400,"current-db-size-bytes":57417728,"current-db-size":"57 MB","current-db-size-in-use-bytes":32579584,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-09-01T04:31:18.425609Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2340909400,"revision":2956,"compact-revision":-1} {"level":"info","ts":"2026-09-01T04:31:50.304854Z","caller":"traceutil/trace.go:171","msg":"trace[1633371351] transaction","detail":"{read_only:false; response_revision:6196; number_of_response:1; }","duration":"145.226529ms","start":"2026-09-01T04:31:50.159583Z","end":"2026-09-01T04:31:50.30481Z","steps":["trace[1633371351] 'process raft request' (duration: 90.064816ms)","trace[1633371351] 'compare' (duration: 54.884125ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:36:18.362477Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5891} {"level":"info","ts":"2026-09-01T04:36:18.599725Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5891,"took":"235.757266ms","hash":4022747894,"current-db-size-bytes":57417728,"current-db-size":"57 MB","current-db-size-in-use-bytes":26271744,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-09-01T04:36:18.599805Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4022747894,"revision":5891,"compact-revision":2956} {"level":"info","ts":"2026-09-01T04:36:55.811878Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002228.wal"} {"level":"info","ts":"2026-09-01T04:36:59.708047Z","caller":"traceutil/trace.go:171","msg":"trace[1720321097] linearizableReadLoop","detail":"{readStateIndex:8766; appliedIndex:8765; }","duration":"419.551717ms","start":"2026-09-01T04:36:59.28847Z","end":"2026-09-01T04:36:59.708022Z","steps":["trace[1720321097] 'read index received' (duration: 419.417353ms)","trace[1720321097] 'applied index is now lower than readState.Index' (duration: 133.344µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:36:59.70808Z","caller":"traceutil/trace.go:171","msg":"trace[643209213] transaction","detail":"{read_only:false; response_revision:8463; number_of_response:1; }","duration":"434.248619ms","start":"2026-09-01T04:36:59.273797Z","end":"2026-09-01T04:36:59.708046Z","steps":["trace[643209213] 'process raft request' (duration: 434.084575ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.708222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.727571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:36:59.708243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.273779Z","time spent":"434.385094ms","remote":"127.0.0.1:44920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T04:36:59.708262Z","caller":"traceutil/trace.go:171","msg":"trace[1596238428] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemmirrors/; range_end:/registry/ceph.rook.io/cephfilesystemmirrors0; response_count:0; response_revision:8463; }","duration":"419.784523ms","start":"2026-09-01T04:36:59.288464Z","end":"2026-09-01T04:36:59.708248Z","steps":["trace[1596238428] 'agreement among raft nodes before linearized reading' (duration: 419.657099ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.708297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.288404Z","time spent":"419.883035ms","remote":"127.0.0.1:58306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" limit:10000 "} {"level":"info","ts":"2026-09-01T04:36:59.966732Z","caller":"traceutil/trace.go:171","msg":"trace[851451941] linearizableReadLoop","detail":"{readStateIndex:8767; appliedIndex:8766; }","duration":"258.591123ms","start":"2026-09-01T04:36:59.708101Z","end":"2026-09-01T04:36:59.966692Z","steps":["trace[851451941] 'read index received' (duration: 256.841123ms)","trace[851451941] 'applied index is now lower than readState.Index' (duration: 1.74844ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:36:59.966797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.628681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:36:59.966807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.098634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:36:59.966825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.909627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:36:59.966878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.939388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:36:59.966881Z","caller":"traceutil/trace.go:171","msg":"trace[60961321] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:8464; }","duration":"409.731014ms","start":"2026-09-01T04:36:59.557126Z","end":"2026-09-01T04:36:59.966857Z","steps":["trace[60961321] 'agreement among raft nodes before linearized reading' (duration: 409.57955ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:36:59.966892Z","caller":"traceutil/trace.go:171","msg":"trace[2067984132] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:8464; }","duration":"394.222218ms","start":"2026-09-01T04:36:59.572646Z","end":"2026-09-01T04:36:59.966869Z","steps":["trace[2067984132] 'agreement among raft nodes before linearized reading' (duration: 394.088644ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.966897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.988631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:36:59.96692Z","caller":"traceutil/trace.go:171","msg":"trace[163213379] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:8464; }","duration":"395.01105ms","start":"2026-09-01T04:36:59.57189Z","end":"2026-09-01T04:36:59.966901Z","steps":["trace[163213379] 'agreement among raft nodes before linearized reading' (duration: 394.970649ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.966933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.55712Z","time spent":"409.798986ms","remote":"127.0.0.1:36932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" limit:500 "} {"level":"warn","ts":"2026-09-01T04:36:59.966943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.572625Z","time spent":"394.301959ms","remote":"127.0.0.1:36936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" limit:500 "} {"level":"warn","ts":"2026-09-01T04:36:59.966953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.510726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:36:59.966957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.57187Z","time spent":"395.079912ms","remote":"127.0.0.1:36936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" count_only:true "} {"level":"info","ts":"2026-09-01T04:36:59.966961Z","caller":"traceutil/trace.go:171","msg":"trace[435038790] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:8464; }","duration":"410.069574ms","start":"2026-09-01T04:36:59.55687Z","end":"2026-09-01T04:36:59.966939Z","steps":["trace[435038790] 'agreement among raft nodes before linearized reading' (duration: 409.987931ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:36:59.966994Z","caller":"traceutil/trace.go:171","msg":"trace[1979447537] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstoreusers/; range_end:/registry/ceph.rook.io/cephobjectstoreusers0; response_count:0; response_revision:8464; }","duration":"526.609179ms","start":"2026-09-01T04:36:59.440365Z","end":"2026-09-01T04:36:59.966975Z","steps":["trace[1979447537] 'agreement among raft nodes before linearized reading' (duration: 526.565367ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.966969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.292449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:36:59.966906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.987143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:36:59.967027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.440348Z","time spent":"526.67061ms","remote":"127.0.0.1:58368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" limit:500 "} {"level":"info","ts":"2026-09-01T04:36:59.967062Z","caller":"traceutil/trace.go:171","msg":"trace[805730468] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:8464; }","duration":"483.188029ms","start":"2026-09-01T04:36:59.483856Z","end":"2026-09-01T04:36:59.967044Z","steps":["trace[805730468] 'agreement among raft nodes before linearized reading' (duration: 482.986713ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.967068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.240467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:36:59.967105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.483838Z","time spent":"483.25318ms","remote":"127.0.0.1:58374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" limit:500 "} {"level":"warn","ts":"2026-09-01T04:36:59.967119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.45376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:36:59.967176Z","caller":"traceutil/trace.go:171","msg":"trace[1991498896] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:8464; }","duration":"356.511452ms","start":"2026-09-01T04:36:59.61063Z","end":"2026-09-01T04:36:59.967142Z","steps":["trace[1991498896] 'agreement among raft nodes before linearized reading' (duration: 356.461141ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.967199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"611.986866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:36:59.967213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.610614Z","time spent":"356.589074ms","remote":"127.0.0.1:36940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" limit:10000 "} {"level":"warn","ts":"2026-09-01T04:36:59.967201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.704098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:36:59.967263Z","caller":"traceutil/trace.go:171","msg":"trace[321105374] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:8464; }","duration":"612.063438ms","start":"2026-09-01T04:36:59.355191Z","end":"2026-09-01T04:36:59.967254Z","steps":["trace[321105374] 'agreement among raft nodes before linearized reading' (duration: 611.943464ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.967294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.355186Z","time spent":"612.099389ms","remote":"127.0.0.1:58330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" limit:500 "} {"level":"info","ts":"2026-09-01T04:36:59.967293Z","caller":"traceutil/trace.go:171","msg":"trace[212196680] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:8464; }","duration":"356.827831ms","start":"2026-09-01T04:36:59.610449Z","end":"2026-09-01T04:36:59.967277Z","steps":["trace[212196680] 'agreement among raft nodes before linearized reading' (duration: 356.670367ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.967346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"635.745049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:36:59.967405Z","caller":"traceutil/trace.go:171","msg":"trace[1462330629] transaction","detail":"{read_only:false; response_revision:8464; number_of_response:1; }","duration":"442.612521ms","start":"2026-09-01T04:36:59.524777Z","end":"2026-09-01T04:36:59.967389Z","steps":["trace[1462330629] 'process raft request' (duration: 440.227852ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.967438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.562697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:36:59.967457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.039247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:36:59.967488Z","caller":"traceutil/trace.go:171","msg":"trace[1066193947] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:8464; }","duration":"410.64087ms","start":"2026-09-01T04:36:59.556833Z","end":"2026-09-01T04:36:59.967474Z","steps":["trace[1066193947] 'agreement among raft nodes before linearized reading' (duration: 410.554657ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:36:59.967497Z","caller":"traceutil/trace.go:171","msg":"trace[916180695] range","detail":"{range_begin:/registry/objectbucket.io/objectbuckets/; range_end:/registry/objectbucket.io/objectbuckets0; response_count:0; response_revision:8464; }","duration":"563.091448ms","start":"2026-09-01T04:36:59.404393Z","end":"2026-09-01T04:36:59.967485Z","steps":["trace[916180695] 'agreement among raft nodes before linearized reading' (duration: 563.027316ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.96751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.562784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:36:59.967528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.556819Z","time spent":"410.696702ms","remote":"127.0.0.1:36932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" limit:10000 "} {"level":"info","ts":"2026-09-01T04:36:59.967541Z","caller":"traceutil/trace.go:171","msg":"trace[1093785059] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:8464; }","duration":"356.611395ms","start":"2026-09-01T04:36:59.61092Z","end":"2026-09-01T04:36:59.967531Z","steps":["trace[1093785059] 'agreement among raft nodes before linearized reading' (duration: 356.562883ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.967536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.404385Z","time spent":"563.139819ms","remote":"127.0.0.1:58350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" count_only:true "} {"level":"warn","ts":"2026-09-01T04:36:59.967543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.524757Z","time spent":"442.691232ms","remote":"127.0.0.1:44920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T04:36:59.96757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.610907Z","time spent":"356.655046ms","remote":"127.0.0.1:36940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" limit:500 "} {"level":"warn","ts":"2026-09-01T04:36:59.967573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.849282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:36:59.967622Z","caller":"traceutil/trace.go:171","msg":"trace[1288422416] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/; range_end:/registry/ceph.rook.io/cephclusters0; response_count:0; response_revision:8464; }","duration":"578.950235ms","start":"2026-09-01T04:36:59.388659Z","end":"2026-09-01T04:36:59.967609Z","steps":["trace[1288422416] 'agreement among raft nodes before linearized reading' (duration: 578.897133ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.9673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.119329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:36:59.96765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.388623Z","time spent":"579.019247ms","remote":"127.0.0.1:58340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":79,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" limit:10000 "} {"level":"info","ts":"2026-09-01T04:36:59.967656Z","caller":"traceutil/trace.go:171","msg":"trace[1014173700] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:8464; }","duration":"612.540661ms","start":"2026-09-01T04:36:59.355106Z","end":"2026-09-01T04:36:59.967646Z","steps":["trace[1014173700] 'agreement among raft nodes before linearized reading' (duration: 612.16581ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.96767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.603142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-mhgpf\" ","response":"range_response_count:1 size:6445"} {"level":"warn","ts":"2026-09-01T04:36:59.967683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.355081Z","time spent":"612.593483ms","remote":"127.0.0.1:58330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" limit:10000 "} {"level":"info","ts":"2026-09-01T04:36:59.967707Z","caller":"traceutil/trace.go:171","msg":"trace[1136899072] range","detail":"{range_begin:/registry/pods/openstack/keepalived-mhgpf; range_end:; response_count:1; response_revision:8464; }","duration":"646.688184ms","start":"2026-09-01T04:36:59.321007Z","end":"2026-09-01T04:36:59.967696Z","steps":["trace[1136899072] 'agreement among raft nodes before linearized reading' (duration: 646.557401ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.967731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.127062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:36:59.967729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.198682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:36:59.967763Z","caller":"traceutil/trace.go:171","msg":"trace[1254757431] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstoreusers/; range_end:/registry/ceph.rook.io/cephobjectstoreusers0; response_count:0; response_revision:8464; }","duration":"528.171843ms","start":"2026-09-01T04:36:59.439581Z","end":"2026-09-01T04:36:59.967753Z","steps":["trace[1254757431] 'agreement among raft nodes before linearized reading' (duration: 528.117271ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.967761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.320978Z","time spent":"646.773877ms","remote":"127.0.0.1:44836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6468,"request content":"key:\"/registry/pods/openstack/keepalived-mhgpf\" "} {"level":"info","ts":"2026-09-01T04:36:59.967773Z","caller":"traceutil/trace.go:171","msg":"trace[1987443446] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:8464; }","duration":"431.280264ms","start":"2026-09-01T04:36:59.53648Z","end":"2026-09-01T04:36:59.967761Z","steps":["trace[1987443446] 'agreement among raft nodes before linearized reading' (duration: 431.208072ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.967347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.610437Z","time spent":"356.893563ms","remote":"127.0.0.1:36940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" count_only:true "} {"level":"warn","ts":"2026-09-01T04:36:59.967794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.439576Z","time spent":"528.208334ms","remote":"127.0.0.1:58368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" count_only:true "} {"level":"warn","ts":"2026-09-01T04:36:59.967807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.221102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:36:59.967819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.536459Z","time spent":"431.346146ms","remote":"127.0.0.1:36920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" limit:500 "} {"level":"info","ts":"2026-09-01T04:36:59.967841Z","caller":"traceutil/trace.go:171","msg":"trace[202176372] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/; range_end:/registry/ceph.rook.io/cephclusters0; response_count:0; response_revision:8464; }","duration":"579.271044ms","start":"2026-09-01T04:36:59.388559Z","end":"2026-09-01T04:36:59.96783Z","steps":["trace[202176372] 'agreement among raft nodes before linearized reading' (duration: 579.223933ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.967868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.388543Z","time spent":"579.317195ms","remote":"127.0.0.1:58340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" count_only:true "} {"level":"info","ts":"2026-09-01T04:36:59.967102Z","caller":"traceutil/trace.go:171","msg":"trace[204465276] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:8464; }","duration":"395.294268ms","start":"2026-09-01T04:36:59.5718Z","end":"2026-09-01T04:36:59.967094Z","steps":["trace[204465276] 'agreement among raft nodes before linearized reading' (duration: 395.244407ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.967911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"612.646054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:36:59.967943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.571768Z","time spent":"396.162903ms","remote":"127.0.0.1:36936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" limit:10000 "} {"level":"warn","ts":"2026-09-01T04:36:59.967954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.43069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:36:59.967961Z","caller":"traceutil/trace.go:171","msg":"trace[540382183] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:8464; }","duration":"612.733927ms","start":"2026-09-01T04:36:59.355212Z","end":"2026-09-01T04:36:59.967946Z","steps":["trace[540382183] 'agreement among raft nodes before linearized reading' (duration: 612.654884ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:36:59.967995Z","caller":"traceutil/trace.go:171","msg":"trace[1376593397] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstoreusers/; range_end:/registry/ceph.rook.io/cephobjectstoreusers0; response_count:0; response_revision:8464; }","duration":"528.500183ms","start":"2026-09-01T04:36:59.439483Z","end":"2026-09-01T04:36:59.967983Z","steps":["trace[1376593397] 'agreement among raft nodes before linearized reading' (duration: 528.436901ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.968004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.355209Z","time spent":"612.782958ms","remote":"127.0.0.1:58330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" count_only:true "} {"level":"warn","ts":"2026-09-01T04:36:59.968029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.439467Z","time spent":"528.551434ms","remote":"127.0.0.1:58368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" limit:10000 "} {"level":"warn","ts":"2026-09-01T04:36:59.968033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.949164ms","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:5"} {"level":"info","ts":"2026-09-01T04:36:59.968078Z","caller":"traceutil/trace.go:171","msg":"trace[537326631] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:8464; }","duration":"432.019906ms","start":"2026-09-01T04:36:59.536045Z","end":"2026-09-01T04:36:59.968065Z","steps":["trace[537326631] 'agreement among raft nodes before linearized reading' (duration: 431.948494ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:36:59.967061Z","caller":"traceutil/trace.go:171","msg":"trace[1878330223] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:8464; }","duration":"378.449393ms","start":"2026-09-01T04:36:59.588589Z","end":"2026-09-01T04:36:59.967039Z","steps":["trace[1878330223] 'agreement among raft nodes before linearized reading' (duration: 378.241777ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:36:59.966908Z","caller":"traceutil/trace.go:171","msg":"trace[858302888] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:8464; }","duration":"378.023101ms","start":"2026-09-01T04:36:59.588867Z","end":"2026-09-01T04:36:59.96689Z","steps":["trace[858302888] 'agreement among raft nodes before linearized reading' (duration: 377.878957ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.966796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.841089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:36:59.967496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.103508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:36:59.968124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.639127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:36:59.968139Z","caller":"traceutil/trace.go:171","msg":"trace[2007883356] range","detail":"{range_begin:/registry/objectbucket.io/objectbuckets/; range_end:/registry/objectbucket.io/objectbuckets0; response_count:0; response_revision:8464; }","duration":"563.778418ms","start":"2026-09-01T04:36:59.404349Z","end":"2026-09-01T04:36:59.968127Z","steps":["trace[2007883356] 'agreement among raft nodes before linearized reading' (duration: 563.110849ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:36:59.968197Z","caller":"traceutil/trace.go:171","msg":"trace[1977650028] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:8464; }","duration":"659.73938ms","start":"2026-09-01T04:36:59.308445Z","end":"2026-09-01T04:36:59.968184Z","steps":["trace[1977650028] 'agreement among raft nodes before linearized reading' (duration: 659.659648ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.967012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.556867Z","time spent":"410.128865ms","remote":"127.0.0.1:36932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" count_only:true "} {"level":"warn","ts":"2026-09-01T04:36:59.968225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.40433Z","time spent":"563.876891ms","remote":"127.0.0.1:58350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":28,"request content":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" limit:10000 "} {"level":"warn","ts":"2026-09-01T04:36:59.968256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.222511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:36:59.968261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.246412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:36:59.968295Z","caller":"traceutil/trace.go:171","msg":"trace[1138379644] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:8464; }","duration":"432.280263ms","start":"2026-09-01T04:36:59.536004Z","end":"2026-09-01T04:36:59.968284Z","steps":["trace[1138379644] 'agreement among raft nodes before linearized reading' (duration: 432.214561ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:36:59.968309Z","caller":"traceutil/trace.go:171","msg":"trace[568522822] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:8464; }","duration":"547.311764ms","start":"2026-09-01T04:36:59.420983Z","end":"2026-09-01T04:36:59.968295Z","steps":["trace[568522822] 'agreement among raft nodes before linearized reading' (duration: 547.230821ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.968327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.535992Z","time spent":"432.326134ms","remote":"127.0.0.1:36920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" limit:10000 "} {"level":"warn","ts":"2026-09-01T04:36:59.968352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.420975Z","time spent":"547.364386ms","remote":"127.0.0.1:58354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" limit:500 "} {"level":"warn","ts":"2026-09-01T04:36:59.968035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.076752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:36:59.968415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"679.372465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:36:59.968434Z","caller":"traceutil/trace.go:171","msg":"trace[94347205] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:8464; }","duration":"659.520644ms","start":"2026-09-01T04:36:59.308896Z","end":"2026-09-01T04:36:59.968417Z","steps":["trace[94347205] 'agreement among raft nodes before linearized reading' (duration: 659.096722ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.968487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.552987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:36:59.96849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.523946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:36:59.968499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.308875Z","time spent":"659.603196ms","remote":"127.0.0.1:58322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":113,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" limit:500 "} {"level":"info","ts":"2026-09-01T04:36:59.968521Z","caller":"traceutil/trace.go:171","msg":"trace[1181362091] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:8464; }","duration":"460.610319ms","start":"2026-09-01T04:36:59.5079Z","end":"2026-09-01T04:36:59.96851Z","steps":["trace[1181362091] 'agreement among raft nodes before linearized reading' (duration: 460.559537ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:36:59.96853Z","caller":"traceutil/trace.go:171","msg":"trace[898566251] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:8464; }","duration":"460.590118ms","start":"2026-09-01T04:36:59.507928Z","end":"2026-09-01T04:36:59.968519Z","steps":["trace[898566251] 'agreement among raft nodes before linearized reading' (duration: 460.523816ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.968543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.859459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:36:59.968561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.507911Z","time spent":"460.640139ms","remote":"127.0.0.1:36902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" count_only:true "} {"level":"warn","ts":"2026-09-01T04:36:59.968563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"679.640343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:36:59.96864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.043905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:36:59.968674Z","caller":"traceutil/trace.go:171","msg":"trace[1384942266] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:8464; }","duration":"548.103867ms","start":"2026-09-01T04:36:59.420561Z","end":"2026-09-01T04:36:59.968665Z","steps":["trace[1384942266] 'agreement among raft nodes before linearized reading' (duration: 548.052246ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:36:59.968657Z","caller":"traceutil/trace.go:171","msg":"trace[1292635903] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemmirrors/; range_end:/registry/ceph.rook.io/cephfilesystemmirrors0; response_count:0; response_revision:8464; }","duration":"679.773347ms","start":"2026-09-01T04:36:59.288869Z","end":"2026-09-01T04:36:59.968642Z","steps":["trace[1292635903] 'agreement among raft nodes before linearized reading' (duration: 679.645823ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.968709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.420547Z","time spent":"548.150488ms","remote":"127.0.0.1:58354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" count_only:true "} {"level":"warn","ts":"2026-09-01T04:36:59.968743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.288849Z","time spent":"679.87706ms","remote":"127.0.0.1:58306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" limit:500 "} {"level":"warn","ts":"2026-09-01T04:36:59.968751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.472931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:36:59.968775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.982044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:36:59.9688Z","caller":"traceutil/trace.go:171","msg":"trace[1671943977] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:8464; }","duration":"446.558564ms","start":"2026-09-01T04:36:59.522226Z","end":"2026-09-01T04:36:59.968784Z","steps":["trace[1671943977] 'agreement among raft nodes before linearized reading' (duration: 446.489862ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.967496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"640.501586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:36:59.968838Z","caller":"traceutil/trace.go:171","msg":"trace[1963760447] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:8464; }","duration":"641.858286ms","start":"2026-09-01T04:36:59.326972Z","end":"2026-09-01T04:36:59.96883Z","steps":["trace[1963760447] 'agreement among raft nodes before linearized reading' (duration: 640.496827ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.968846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.522221Z","time spent":"446.612975ms","remote":"127.0.0.1:36904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" limit:500 "} {"level":"warn","ts":"2026-09-01T04:36:59.968865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.326962Z","time spent":"641.894647ms","remote":"127.0.0.1:58324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" count_only:true "} {"level":"warn","ts":"2026-09-01T04:36:59.967538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.306777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:36:59.968911Z","caller":"traceutil/trace.go:171","msg":"trace[748564156] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/; range_end:/registry/ceph.rook.io/cephclusters0; response_count:0; response_revision:8464; }","duration":"579.713967ms","start":"2026-09-01T04:36:59.389185Z","end":"2026-09-01T04:36:59.968899Z","steps":["trace[748564156] 'agreement among raft nodes before linearized reading' (duration: 578.332917ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.968954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.389164Z","time spent":"579.776838ms","remote":"127.0.0.1:58340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":79,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" limit:500 "} {"level":"warn","ts":"2026-09-01T04:36:59.967549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"640.590259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:36:59.968993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.265631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:36:59.966808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.094083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:36:59.969033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.14618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:36:59.969049Z","caller":"traceutil/trace.go:171","msg":"trace[5307821] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:8464; }","duration":"380.377449ms","start":"2026-09-01T04:36:59.588663Z","end":"2026-09-01T04:36:59.96904Z","steps":["trace[5307821] 'agreement among raft nodes before linearized reading' (duration: 378.074213ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:36:59.969044Z","caller":"traceutil/trace.go:171","msg":"trace[102788576] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8464; }","duration":"162.338723ms","start":"2026-09-01T04:36:59.806688Z","end":"2026-09-01T04:36:59.969027Z","steps":["trace[102788576] 'agreement among raft nodes before linearized reading' (duration: 162.26441ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:36:59.969065Z","caller":"traceutil/trace.go:171","msg":"trace[909258679] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:8464; }","duration":"447.177901ms","start":"2026-09-01T04:36:59.521876Z","end":"2026-09-01T04:36:59.969054Z","steps":["trace[909258679] 'agreement among raft nodes before linearized reading' (duration: 447.13036ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.969081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.588654Z","time spent":"380.41619ms","remote":"127.0.0.1:36938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" count_only:true "} {"level":"warn","ts":"2026-09-01T04:36:59.969092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.52186Z","time spent":"447.224673ms","remote":"127.0.0.1:36904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" count_only:true "} {"level":"info","ts":"2026-09-01T04:36:59.968588Z","caller":"traceutil/trace.go:171","msg":"trace[88822847] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:8464; }","duration":"547.941273ms","start":"2026-09-01T04:36:59.420634Z","end":"2026-09-01T04:36:59.968575Z","steps":["trace[88822847] 'agreement among raft nodes before linearized reading' (duration: 547.873911ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.969182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.420585Z","time spent":"548.55575ms","remote":"127.0.0.1:58354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" limit:10000 "} {"level":"warn","ts":"2026-09-01T04:36:59.969242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.456979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:36:59.969258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.308426Z","time spent":"660.812631ms","remote":"127.0.0.1:58322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" count_only:true "} {"level":"warn","ts":"2026-09-01T04:36:59.969307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.444373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:36:59.968551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.507885Z","time spent":"460.65707ms","remote":"127.0.0.1:36902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" limit:10000 "} {"level":"info","ts":"2026-09-01T04:36:59.969332Z","caller":"traceutil/trace.go:171","msg":"trace[2136722789] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:8464; }","duration":"460.479834ms","start":"2026-09-01T04:36:59.508845Z","end":"2026-09-01T04:36:59.969325Z","steps":["trace[2136722789] 'agreement among raft nodes before linearized reading' (duration: 460.441913ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.969362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.508838Z","time spent":"460.516536ms","remote":"127.0.0.1:36902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" limit:500 "} {"level":"warn","ts":"2026-09-01T04:36:59.96859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.567648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:36:59.969271Z","caller":"traceutil/trace.go:171","msg":"trace[440404605] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:8464; }","duration":"447.499371ms","start":"2026-09-01T04:36:59.521762Z","end":"2026-09-01T04:36:59.969261Z","steps":["trace[440404605] 'agreement among raft nodes before linearized reading' (duration: 447.45747ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:36:59.969433Z","caller":"traceutil/trace.go:171","msg":"trace[782622824] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:8464; }","duration":"485.446003ms","start":"2026-09-01T04:36:59.483978Z","end":"2026-09-01T04:36:59.969424Z","steps":["trace[782622824] 'agreement among raft nodes before linearized reading' (duration: 484.591208ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.969459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.483916Z","time spent":"485.534476ms","remote":"127.0.0.1:58374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" count_only:true "} {"level":"warn","ts":"2026-09-01T04:36:59.969457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.521753Z","time spent":"447.693147ms","remote":"127.0.0.1:36904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" limit:10000 "} {"level":"info","ts":"2026-09-01T04:36:59.969006Z","caller":"traceutil/trace.go:171","msg":"trace[1250393660] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:8464; }","duration":"642.071412ms","start":"2026-09-01T04:36:59.326925Z","end":"2026-09-01T04:36:59.968996Z","steps":["trace[1250393660] 'agreement among raft nodes before linearized reading' (duration: 640.591419ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:36:59.968809Z","caller":"traceutil/trace.go:171","msg":"trace[750997946] range","detail":"{range_begin:/registry/objectbucket.io/objectbuckets/; range_end:/registry/objectbucket.io/objectbuckets0; response_count:0; response_revision:8464; }","duration":"564.059156ms","start":"2026-09-01T04:36:59.40474Z","end":"2026-09-01T04:36:59.9688Z","steps":["trace[750997946] 'agreement among raft nodes before linearized reading' (duration: 564.007445ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.969547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.326918Z","time spent":"642.615427ms","remote":"127.0.0.1:58324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" limit:10000 "} {"level":"warn","ts":"2026-09-01T04:36:59.969578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.404724Z","time spent":"564.843918ms","remote":"127.0.0.1:58350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":28,"request content":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" limit:500 "} {"level":"warn","ts":"2026-09-01T04:36:59.968081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.562705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:36:59.969729Z","caller":"traceutil/trace.go:171","msg":"trace[1715085498] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:8464; }","duration":"661.237423ms","start":"2026-09-01T04:36:59.308472Z","end":"2026-09-01T04:36:59.969709Z","steps":["trace[1715085498] 'agreement among raft nodes before linearized reading' (duration: 659.588136ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.969786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.308452Z","time spent":"661.319356ms","remote":"127.0.0.1:58322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":113,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" limit:10000 "} {"level":"warn","ts":"2026-09-01T04:36:59.969859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.536032Z","time spent":"433.818707ms","remote":"127.0.0.1:36920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true "} {"level":"info","ts":"2026-09-01T04:36:59.967449Z","caller":"traceutil/trace.go:171","msg":"trace[231110890] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:8464; }","duration":"635.878373ms","start":"2026-09-01T04:36:59.331558Z","end":"2026-09-01T04:36:59.967437Z","steps":["trace[231110890] 'agreement among raft nodes before linearized reading' (duration: 635.76316ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.969974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.588575Z","time spent":"381.389217ms","remote":"127.0.0.1:36938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" limit:10000 "} {"level":"warn","ts":"2026-09-01T04:36:59.969973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.331542Z","time spent":"638.417926ms","remote":"127.0.0.1:58324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" limit:500 "} {"level":"info","ts":"2026-09-01T04:36:59.970047Z","caller":"traceutil/trace.go:171","msg":"trace[1286521072] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:8464; }","duration":"486.122142ms","start":"2026-09-01T04:36:59.483911Z","end":"2026-09-01T04:36:59.970034Z","steps":["trace[1286521072] 'agreement among raft nodes before linearized reading' (duration: 482.786467ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.970093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.483905Z","time spent":"486.172154ms","remote":"127.0.0.1:58374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" limit:10000 "} {"level":"warn","ts":"2026-09-01T04:36:59.970095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.588857Z","time spent":"381.227503ms","remote":"127.0.0.1:36938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" limit:500 "} {"level":"info","ts":"2026-09-01T04:36:59.96845Z","caller":"traceutil/trace.go:171","msg":"trace[1351428982] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemmirrors/; range_end:/registry/ceph.rook.io/cephfilesystemmirrors0; response_count:0; response_revision:8464; }","duration":"679.459768ms","start":"2026-09-01T04:36:59.288979Z","end":"2026-09-01T04:36:59.968438Z","steps":["trace[1351428982] 'agreement among raft nodes before linearized reading' (duration: 679.402956ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:36:59.970349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:36:59.288947Z","time spent":"681.389413ms","remote":"127.0.0.1:58306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" count_only:true "} {"level":"info","ts":"2026-09-01T04:37:11.292265Z","caller":"traceutil/trace.go:171","msg":"trace[2013542220] linearizableReadLoop","detail":"{readStateIndex:8825; appliedIndex:8824; }","duration":"231.034464ms","start":"2026-09-01T04:37:11.061207Z","end":"2026-09-01T04:37:11.292242Z","steps":["trace[2013542220] 'read index received' (duration: 230.775327ms)","trace[2013542220] 'applied index is now lower than readState.Index' (duration: 258.117µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:37:11.29232Z","caller":"traceutil/trace.go:171","msg":"trace[1351107382] transaction","detail":"{read_only:false; response_revision:8520; number_of_response:1; }","duration":"304.042001ms","start":"2026-09-01T04:37:10.988252Z","end":"2026-09-01T04:37:11.292294Z","steps":["trace[1351107382] 'process raft request' (duration: 303.822065ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:37:11.292453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:37:10.988223Z","time spent":"304.154214ms","remote":"127.0.0.1:44920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T04:37:11.292475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.2444ms","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-09-01T04:37:11.292519Z","caller":"traceutil/trace.go:171","msg":"trace[1490175079] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8520; }","duration":"231.330773ms","start":"2026-09-01T04:37:11.061174Z","end":"2026-09-01T04:37:11.292505Z","steps":["trace[1490175079] 'agreement among raft nodes before linearized reading' (duration: 231.178179ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:37:11.292557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.191105ms","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-09-01T04:37:11.292615Z","caller":"traceutil/trace.go:171","msg":"trace[1448458122] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8520; }","duration":"218.276578ms","start":"2026-09-01T04:37:11.074322Z","end":"2026-09-01T04:37:11.292599Z","steps":["trace[1448458122] 'agreement among raft nodes before linearized reading' (duration: 218.158214ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:37:11.292677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.312109ms","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-09-01T04:37:11.292717Z","caller":"traceutil/trace.go:171","msg":"trace[1762727660] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8520; }","duration":"218.383271ms","start":"2026-09-01T04:37:11.074322Z","end":"2026-09-01T04:37:11.292706Z","steps":["trace[1762727660] 'agreement among raft nodes before linearized reading' (duration: 218.116633ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:37:12.046346Z","caller":"traceutil/trace.go:171","msg":"trace[1394148498] linearizableReadLoop","detail":"{readStateIndex:8833; appliedIndex:8832; }","duration":"240.791294ms","start":"2026-09-01T04:37:11.805527Z","end":"2026-09-01T04:37:12.046318Z","steps":["trace[1394148498] 'read index received' (duration: 240.580948ms)","trace[1394148498] 'applied index is now lower than readState.Index' (duration: 208.226µs)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:37:12.046568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.028702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:37:12.046614Z","caller":"traceutil/trace.go:171","msg":"trace[1746746851] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8527; }","duration":"241.118945ms","start":"2026-09-01T04:37:11.805484Z","end":"2026-09-01T04:37:12.046603Z","steps":["trace[1746746851] 'agreement among raft nodes before linearized reading' (duration: 240.926509ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:37:12.046911Z","caller":"traceutil/trace.go:171","msg":"trace[670803962] transaction","detail":"{read_only:false; response_revision:8527; number_of_response:1; }","duration":"291.83529ms","start":"2026-09-01T04:37:11.754621Z","end":"2026-09-01T04:37:12.046456Z","steps":["trace[670803962] 'process raft request' (duration: 291.47167ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:37:12.061876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.274991ms","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-09-01T04:37:12.061956Z","caller":"traceutil/trace.go:171","msg":"trace[1855711361] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:8528; }","duration":"122.400635ms","start":"2026-09-01T04:37:11.939535Z","end":"2026-09-01T04:37:12.061936Z","steps":["trace[1855711361] 'agreement among raft nodes before linearized reading' (duration: 122.22328ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:37:40.706812Z","caller":"traceutil/trace.go:171","msg":"trace[871118606] linearizableReadLoop","detail":"{readStateIndex:9049; appliedIndex:9048; }","duration":"232.216998ms","start":"2026-09-01T04:37:40.474571Z","end":"2026-09-01T04:37:40.706788Z","steps":["trace[871118606] 'read index received' (duration: 231.892389ms)","trace[871118606] 'applied index is now lower than readState.Index' (duration: 323.319µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:37:40.706927Z","caller":"traceutil/trace.go:171","msg":"trace[471815471] transaction","detail":"{read_only:false; response_revision:8736; number_of_response:1; }","duration":"365.994ms","start":"2026-09-01T04:37:40.340923Z","end":"2026-09-01T04:37:40.706917Z","steps":["trace[471815471] 'process raft request' (duration: 365.65005ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:37:40.707029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:37:40.3409Z","time spent":"366.054112ms","remote":"127.0.0.1:44920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T04:37:40.707203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.62831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-01T04:37:40.707316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.553753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-09-01T04:37:40.707387Z","caller":"traceutil/trace.go:171","msg":"trace[1202583243] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:8736; }","duration":"134.678367ms","start":"2026-09-01T04:37:40.572691Z","end":"2026-09-01T04:37:40.707369Z","steps":["trace[1202583243] 'agreement among raft nodes before linearized reading' (duration: 134.512752ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:37:40.707282Z","caller":"traceutil/trace.go:171","msg":"trace[1864999486] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:8736; }","duration":"232.733443ms","start":"2026-09-01T04:37:40.474534Z","end":"2026-09-01T04:37:40.707267Z","steps":["trace[1864999486] 'agreement among raft nodes before linearized reading' (duration: 232.63655ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:37:40.707417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.622341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:37:40.707669Z","caller":"traceutil/trace.go:171","msg":"trace[1606735691] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:8736; }","duration":"130.893179ms","start":"2026-09-01T04:37:40.576754Z","end":"2026-09-01T04:37:40.707648Z","steps":["trace[1606735691] 'agreement among raft nodes before linearized reading' (duration: 130.631391ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:37:43.726552Z","caller":"traceutil/trace.go:171","msg":"trace[1386600430] linearizableReadLoop","detail":"{readStateIndex:9065; appliedIndex:9064; }","duration":"233.938568ms","start":"2026-09-01T04:37:43.492595Z","end":"2026-09-01T04:37:43.726534Z","steps":["trace[1386600430] 'read index received' (duration: 233.742872ms)","trace[1386600430] 'applied index is now lower than readState.Index' (duration: 195.156µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:37:43.726611Z","caller":"traceutil/trace.go:171","msg":"trace[574159575] transaction","detail":"{read_only:false; response_revision:8750; number_of_response:1; }","duration":"288.165666ms","start":"2026-09-01T04:37:43.438405Z","end":"2026-09-01T04:37:43.726571Z","steps":["trace[574159575] 'process raft request' (duration: 287.98238ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:37:43.726726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.145347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-09-01T04:37:43.726726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.881848ms","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-09-01T04:37:43.726753Z","caller":"traceutil/trace.go:171","msg":"trace[616705425] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8750; }","duration":"223.21078ms","start":"2026-09-01T04:37:43.503535Z","end":"2026-09-01T04:37:43.726745Z","steps":["trace[616705425] 'agreement among raft nodes before linearized reading' (duration: 223.094156ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:37:43.726762Z","caller":"traceutil/trace.go:171","msg":"trace[880696319] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8750; }","duration":"216.959791ms","start":"2026-09-01T04:37:43.509793Z","end":"2026-09-01T04:37:43.726753Z","steps":["trace[880696319] 'agreement among raft nodes before linearized reading' (duration: 216.843058ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:37:43.726773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.153655ms","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-09-01T04:37:43.72687Z","caller":"traceutil/trace.go:171","msg":"trace[682948057] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8750; }","duration":"234.258888ms","start":"2026-09-01T04:37:43.492587Z","end":"2026-09-01T04:37:43.726846Z","steps":["trace[682948057] 'agreement among raft nodes before linearized reading' (duration: 234.016951ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:37:43.7268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.977052ms","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-09-01T04:37:43.72702Z","caller":"traceutil/trace.go:171","msg":"trace[932981568] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8750; }","duration":"217.27753ms","start":"2026-09-01T04:37:43.509724Z","end":"2026-09-01T04:37:43.727002Z","steps":["trace[932981568] 'agreement among raft nodes before linearized reading' (duration: 216.93041ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:37:43.944879Z","caller":"traceutil/trace.go:171","msg":"trace[1925321869] transaction","detail":"{read_only:false; response_revision:8752; number_of_response:1; }","duration":"213.648466ms","start":"2026-09-01T04:37:43.731208Z","end":"2026-09-01T04:37:43.944856Z","steps":["trace[1925321869] 'process raft request' (duration: 213.538993ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:37:43.944889Z","caller":"traceutil/trace.go:171","msg":"trace[434749140] transaction","detail":"{read_only:false; response_revision:8751; number_of_response:1; }","duration":"214.123229ms","start":"2026-09-01T04:37:43.730737Z","end":"2026-09-01T04:37:43.94486Z","steps":["trace[434749140] 'process raft request' (duration: 113.983553ms)","trace[434749140] 'compare' (duration: 99.808606ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:37:43.944991Z","caller":"traceutil/trace.go:171","msg":"trace[1564325866] linearizableReadLoop","detail":"{readStateIndex:9069; appliedIndex:9065; }","duration":"136.84632ms","start":"2026-09-01T04:37:43.808126Z","end":"2026-09-01T04:37:43.944973Z","steps":["trace[1564325866] 'read index received' (duration: 36.675093ms)","trace[1564325866] 'applied index is now lower than readState.Index' (duration: 100.170467ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:37:43.945049Z","caller":"traceutil/trace.go:171","msg":"trace[2027323007] transaction","detail":"{read_only:false; response_revision:8753; number_of_response:1; }","duration":"213.742808ms","start":"2026-09-01T04:37:43.731282Z","end":"2026-09-01T04:37:43.945025Z","steps":["trace[2027323007] 'process raft request' (duration: 213.542192ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:37:43.945084Z","caller":"traceutil/trace.go:171","msg":"trace[1980586109] transaction","detail":"{read_only:false; response_revision:8754; number_of_response:1; }","duration":"213.517912ms","start":"2026-09-01T04:37:43.731542Z","end":"2026-09-01T04:37:43.94506Z","steps":["trace[1980586109] 'process raft request' (duration: 213.366427ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:37:43.945141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.004194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:37:43.945177Z","caller":"traceutil/trace.go:171","msg":"trace[1341468443] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8754; }","duration":"137.103588ms","start":"2026-09-01T04:37:43.808065Z","end":"2026-09-01T04:37:43.945168Z","steps":["trace[1341468443] 'agreement among raft nodes before linearized reading' (duration: 136.987964ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:37:51.715623Z","caller":"traceutil/trace.go:171","msg":"trace[1699025274] linearizableReadLoop","detail":"{readStateIndex:9108; appliedIndex:9107; }","duration":"140.581517ms","start":"2026-09-01T04:37:51.575019Z","end":"2026-09-01T04:37:51.7156Z","steps":["trace[1699025274] 'read index received' (duration: 140.35416ms)","trace[1699025274] 'applied index is now lower than readState.Index' (duration: 226.377µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:37:51.715707Z","caller":"traceutil/trace.go:171","msg":"trace[2040708867] transaction","detail":"{read_only:false; response_revision:8792; number_of_response:1; }","duration":"153.265591ms","start":"2026-09-01T04:37:51.562411Z","end":"2026-09-01T04:37:51.715677Z","steps":["trace[2040708867] 'process raft request' (duration: 152.996913ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:37:51.715834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.800423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.119\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-09-01T04:37:51.715873Z","caller":"traceutil/trace.go:171","msg":"trace[751481301] range","detail":"{range_begin:/registry/masterleases/162.253.55.119; range_end:; response_count:1; response_revision:8792; }","duration":"140.886055ms","start":"2026-09-01T04:37:51.574976Z","end":"2026-09-01T04:37:51.715862Z","steps":["trace[751481301] 'agreement among raft nodes before linearized reading' (duration: 140.741121ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:37:51.938578Z","caller":"traceutil/trace.go:171","msg":"trace[1905127704] linearizableReadLoop","detail":"{readStateIndex:9110; appliedIndex:9109; }","duration":"173.296557ms","start":"2026-09-01T04:37:51.765239Z","end":"2026-09-01T04:37:51.938535Z","steps":["trace[1905127704] 'read index received' (duration: 122.655072ms)","trace[1905127704] 'applied index is now lower than readState.Index' (duration: 50.640105ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:37:51.938583Z","caller":"traceutil/trace.go:171","msg":"trace[866695846] transaction","detail":"{read_only:false; response_revision:8793; number_of_response:1; }","duration":"214.790818ms","start":"2026-09-01T04:37:51.723762Z","end":"2026-09-01T04:37:51.938553Z","steps":["trace[866695846] 'process raft request' (duration: 164.106053ms)","trace[866695846] 'compare' (duration: 50.531621ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:37:51.938783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.529413ms","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-09-01T04:37:51.93883Z","caller":"traceutil/trace.go:171","msg":"trace[1269847839] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8793; }","duration":"173.623786ms","start":"2026-09-01T04:37:51.765199Z","end":"2026-09-01T04:37:51.938823Z","steps":["trace[1269847839] 'agreement among raft nodes before linearized reading' (duration: 173.43101ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:37:51.938899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.617368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:37:51.938953Z","caller":"traceutil/trace.go:171","msg":"trace[199748579] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8793; }","duration":"132.712701ms","start":"2026-09-01T04:37:51.806224Z","end":"2026-09-01T04:37:51.938937Z","steps":["trace[199748579] 'agreement among raft nodes before linearized reading' (duration: 132.626239ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:37:52.152479Z","caller":"traceutil/trace.go:171","msg":"trace[1243099392] transaction","detail":"{read_only:false; response_revision:8798; number_of_response:1; }","duration":"130.216909ms","start":"2026-09-01T04:37:52.022227Z","end":"2026-09-01T04:37:52.152443Z","steps":["trace[1243099392] 'process raft request' (duration: 130.006553ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:37:52.502947Z","caller":"traceutil/trace.go:171","msg":"trace[170094497] transaction","detail":"{read_only:false; response_revision:8801; number_of_response:1; }","duration":"181.634206ms","start":"2026-09-01T04:37:52.321292Z","end":"2026-09-01T04:37:52.502926Z","steps":["trace[170094497] 'process raft request' (duration: 181.410909ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:39:21.626983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.72591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-09-01T04:39:21.627133Z","caller":"traceutil/trace.go:171","msg":"trace[1170047380] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9654; }","duration":"164.936256ms","start":"2026-09-01T04:39:21.462182Z","end":"2026-09-01T04:39:21.627118Z","steps":["trace[1170047380] 'range keys from in-memory index tree' (duration: 164.559185ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:39:22.472875Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"2f0e00eb3c3ee1b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-01T04:39:22.479759Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-09-01T04:39:22.479869Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-09-01T04:41:18.370354Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8071} {"level":"info","ts":"2026-09-01T04:41:18.436834Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8071,"took":"63.954105ms","hash":1060888619,"current-db-size-bytes":57417728,"current-db-size":"57 MB","current-db-size-in-use-bytes":28254208,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-01T04:41:18.436888Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1060888619,"revision":8071,"compact-revision":5891} {"level":"info","ts":"2026-09-01T04:44:52.638409Z","caller":"traceutil/trace.go:171","msg":"trace[1268062084] transaction","detail":"{read_only:false; response_revision:12035; number_of_response:1; }","duration":"119.253041ms","start":"2026-09-01T04:44:52.519105Z","end":"2026-09-01T04:44:52.638358Z","steps":["trace[1268062084] 'process raft request' (duration: 92.079268ms)","trace[1268062084] 'compare' (duration: 26.945226ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:45:10.795987Z","caller":"traceutil/trace.go:171","msg":"trace[816694798] linearizableReadLoop","detail":"{readStateIndex:12559; appliedIndex:12558; }","duration":"170.998991ms","start":"2026-09-01T04:45:10.624895Z","end":"2026-09-01T04:45:10.795894Z","steps":["trace[816694798] 'read index received' (duration: 141.785738ms)","trace[816694798] 'applied index is now lower than readState.Index' (duration: 29.211733ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:45:10.796014Z","caller":"traceutil/trace.go:171","msg":"trace[1484890474] transaction","detail":"{read_only:false; response_revision:12135; number_of_response:1; }","duration":"243.124297ms","start":"2026-09-01T04:45:10.552784Z","end":"2026-09-01T04:45:10.795908Z","steps":["trace[1484890474] 'process raft request' (duration: 213.638926ms)","trace[1484890474] 'compare' (duration: 29.299535ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:45:10.796428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.512036ms","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-09-01T04:45:10.796508Z","caller":"traceutil/trace.go:171","msg":"trace[1399894907] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:12135; }","duration":"171.640249ms","start":"2026-09-01T04:45:10.624846Z","end":"2026-09-01T04:45:10.796486Z","steps":["trace[1399894907] 'agreement among raft nodes before linearized reading' (duration: 171.204167ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:45:10.823617Z","caller":"traceutil/trace.go:171","msg":"trace[2051524002] transaction","detail":"{read_only:false; response_revision:12136; number_of_response:1; }","duration":"128.396258ms","start":"2026-09-01T04:45:10.695199Z","end":"2026-09-01T04:45:10.823595Z","steps":["trace[2051524002] 'process raft request' (duration: 128.266334ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:45:11.860704Z","caller":"traceutil/trace.go:171","msg":"trace[684076413] linearizableReadLoop","detail":"{readStateIndex:12563; appliedIndex:12562; }","duration":"264.832591ms","start":"2026-09-01T04:45:11.59585Z","end":"2026-09-01T04:45:11.860683Z","steps":["trace[684076413] 'read index received' (duration: 264.690896ms)","trace[684076413] 'applied index is now lower than readState.Index' (duration: 140.794µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:45:11.860776Z","caller":"traceutil/trace.go:171","msg":"trace[795668110] transaction","detail":"{read_only:false; response_revision:12139; number_of_response:1; }","duration":"297.479364ms","start":"2026-09-01T04:45:11.563261Z","end":"2026-09-01T04:45:11.86074Z","steps":["trace[795668110] 'process raft request' (duration: 297.243727ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:45:11.860873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.162005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-01T04:45:11.86091Z","caller":"traceutil/trace.go:171","msg":"trace[1111567208] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:12139; }","duration":"197.217397ms","start":"2026-09-01T04:45:11.663682Z","end":"2026-09-01T04:45:11.8609Z","steps":["trace[1111567208] 'agreement among raft nodes before linearized reading' (duration: 197.121524ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:45:11.860958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.074708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.119\" ","response":"range_response_count:1 size:138"} {"level":"info","ts":"2026-09-01T04:45:11.861031Z","caller":"traceutil/trace.go:171","msg":"trace[1413396621] range","detail":"{range_begin:/registry/masterleases/162.253.55.119; range_end:; response_count:1; response_revision:12139; }","duration":"265.213942ms","start":"2026-09-01T04:45:11.595799Z","end":"2026-09-01T04:45:11.861013Z","steps":["trace[1413396621] 'agreement among raft nodes before linearized reading' (duration: 264.969875ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:45:11.981864Z","caller":"traceutil/trace.go:171","msg":"trace[2077665340] transaction","detail":"{read_only:false; response_revision:12140; number_of_response:1; }","duration":"100.954887ms","start":"2026-09-01T04:45:11.880877Z","end":"2026-09-01T04:45:11.981832Z","steps":["trace[2077665340] 'process raft request' (duration: 39.812432ms)","trace[2077665340] 'compare' (duration: 60.915668ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:46:18.377252Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10475} {"level":"info","ts":"2026-09-01T04:46:18.472094Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10475,"took":"92.578009ms","hash":143399056,"current-db-size-bytes":57417728,"current-db-size":"57 MB","current-db-size-in-use-bytes":25845760,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-09-01T04:46:18.472184Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":143399056,"revision":10475,"compact-revision":8071} {"level":"info","ts":"2026-09-01T04:51:18.439662Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12598} {"level":"info","ts":"2026-09-01T04:51:18.599259Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12598,"took":"157.71825ms","hash":869483674,"current-db-size-bytes":57417728,"current-db-size":"57 MB","current-db-size-in-use-bytes":27324416,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-09-01T04:51:18.599371Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":869483674,"revision":12598,"compact-revision":10475} {"level":"info","ts":"2026-09-01T04:51:25.742985Z","caller":"traceutil/trace.go:171","msg":"trace[1661579718] transaction","detail":"{read_only:false; response_revision:14663; number_of_response:1; }","duration":"110.822738ms","start":"2026-09-01T04:51:25.632131Z","end":"2026-09-01T04:51:25.742954Z","steps":["trace[1661579718] 'process raft request' (duration: 110.628132ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:52:06.035332Z","caller":"traceutil/trace.go:171","msg":"trace[580493385] transaction","detail":"{read_only:false; response_revision:14882; number_of_response:1; }","duration":"131.414036ms","start":"2026-09-01T04:52:05.903886Z","end":"2026-09-01T04:52:06.0353Z","steps":["trace[580493385] 'process raft request' (duration: 131.238061ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:52:06.943955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.586923ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T04:52:06.944062Z","caller":"traceutil/trace.go:171","msg":"trace[309681249] transaction","detail":"{read_only:false; response_revision:14885; number_of_response:1; }","duration":"412.428066ms","start":"2026-09-01T04:52:06.531611Z","end":"2026-09-01T04:52:06.944039Z","steps":["trace[309681249] 'process raft request' (duration: 240.671908ms)","trace[309681249] 'compare' (duration: 171.450309ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:52:06.944118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:52:06.531585Z","time spent":"412.508298ms","remote":"127.0.0.1:44920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T04:52:07.073271Z","caller":"traceutil/trace.go:171","msg":"trace[516581932] linearizableReadLoop","detail":"{readStateIndex:15409; appliedIndex:15407; }","duration":"522.291957ms","start":"2026-09-01T04:52:06.550954Z","end":"2026-09-01T04:52:07.073246Z","steps":["trace[516581932] 'read index received' (duration: 221.491942ms)","trace[516581932] 'applied index is now lower than readState.Index' (duration: 300.798775ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:52:07.073309Z","caller":"traceutil/trace.go:171","msg":"trace[579457524] transaction","detail":"{read_only:false; response_revision:14886; number_of_response:1; }","duration":"531.688419ms","start":"2026-09-01T04:52:06.541577Z","end":"2026-09-01T04:52:07.073266Z","steps":["trace[579457524] 'process raft request' (duration: 531.503374ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:52:07.073482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.506602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:52:07.073517Z","caller":"traceutil/trace.go:171","msg":"trace[664410756] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14886; }","duration":"263.78026ms","start":"2026-09-01T04:52:06.809726Z","end":"2026-09-01T04:52:07.073507Z","steps":["trace[664410756] 'agreement among raft nodes before linearized reading' (duration: 263.676427ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:52:07.07354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:52:06.541531Z","time spent":"531.863344ms","remote":"127.0.0.1:44836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11815,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T04:52:07.073545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.579555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" ","response":"range_response_count:1 size:1857"} {"level":"info","ts":"2026-09-01T04:52:07.073601Z","caller":"traceutil/trace.go:171","msg":"trace[459447853] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0; range_end:; response_count:1; response_revision:14886; }","duration":"522.664898ms","start":"2026-09-01T04:52:06.550918Z","end":"2026-09-01T04:52:07.073583Z","steps":["trace[459447853] 'agreement among raft nodes before linearized reading' (duration: 522.458712ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:52:07.073632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:52:06.550908Z","time spent":"522.715459ms","remote":"127.0.0.1:44822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":1,"response size":1880,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" "} {"level":"warn","ts":"2026-09-01T04:52:07.073858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.806193ms","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-09-01T04:52:07.073949Z","caller":"traceutil/trace.go:171","msg":"trace[1004479860] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14886; }","duration":"126.939266ms","start":"2026-09-01T04:52:06.946986Z","end":"2026-09-01T04:52:07.073925Z","steps":["trace[1004479860] 'agreement among raft nodes before linearized reading' (duration: 126.624597ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:52:08.68222Z","caller":"traceutil/trace.go:171","msg":"trace[243654662] transaction","detail":"{read_only:false; response_revision:14900; number_of_response:1; }","duration":"115.659539ms","start":"2026-09-01T04:52:08.566534Z","end":"2026-09-01T04:52:08.682193Z","steps":["trace[243654662] 'process raft request' (duration: 115.489314ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:52:17.857268Z","caller":"traceutil/trace.go:171","msg":"trace[615238151] linearizableReadLoop","detail":"{readStateIndex:15587; appliedIndex:15586; }","duration":"184.421285ms","start":"2026-09-01T04:52:17.672822Z","end":"2026-09-01T04:52:17.857243Z","steps":["trace[615238151] 'read index received' (duration: 184.322952ms)","trace[615238151] 'applied index is now lower than readState.Index' (duration: 96.563µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:52:17.857342Z","caller":"traceutil/trace.go:171","msg":"trace[104717967] transaction","detail":"{read_only:false; response_revision:15060; number_of_response:1; }","duration":"204.764235ms","start":"2026-09-01T04:52:17.652552Z","end":"2026-09-01T04:52:17.857317Z","steps":["trace[104717967] 'process raft request' (duration: 204.541749ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:52:17.857511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.676502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/ovn-northd-7659bd74f8-dgljt\" ","response":"range_response_count:1 size:6895"} {"level":"info","ts":"2026-09-01T04:52:17.857557Z","caller":"traceutil/trace.go:171","msg":"trace[997517004] range","detail":"{range_begin:/registry/pods/openstack/ovn-northd-7659bd74f8-dgljt; range_end:; response_count:1; response_revision:15060; }","duration":"184.791746ms","start":"2026-09-01T04:52:17.672751Z","end":"2026-09-01T04:52:17.857543Z","steps":["trace[997517004] 'agreement among raft nodes before linearized reading' (duration: 184.605471ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:52:17.86237Z","caller":"traceutil/trace.go:171","msg":"trace[119443291] transaction","detail":"{read_only:false; response_revision:15061; number_of_response:1; }","duration":"168.068151ms","start":"2026-09-01T04:52:17.694284Z","end":"2026-09-01T04:52:17.862352Z","steps":["trace[119443291] 'process raft request' (duration: 167.914026ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:52:17.862723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.226439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/ovn-controller-default-bs9pk.18d1194acfe1864e\" ","response":"range_response_count:1 size:783"} {"level":"info","ts":"2026-09-01T04:52:17.862773Z","caller":"traceutil/trace.go:171","msg":"trace[2026592421] range","detail":"{range_begin:/registry/events/openstack/ovn-controller-default-bs9pk.18d1194acfe1864e; range_end:; response_count:1; response_revision:15061; }","duration":"174.360643ms","start":"2026-09-01T04:52:17.688397Z","end":"2026-09-01T04:52:17.862758Z","steps":["trace[2026592421] 'agreement among raft nodes before linearized reading' (duration: 173.90218ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:52:22.49269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.542615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3684"} {"level":"info","ts":"2026-09-01T04:52:22.492786Z","caller":"traceutil/trace.go:171","msg":"trace[1259321798] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:15156; }","duration":"105.679228ms","start":"2026-09-01T04:52:22.387082Z","end":"2026-09-01T04:52:22.492762Z","steps":["trace[1259321798] 'agreement among raft nodes before linearized reading' (duration: 105.379479ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:52:23.171284Z","caller":"traceutil/trace.go:171","msg":"trace[1422288069] linearizableReadLoop","detail":"{readStateIndex:15716; appliedIndex:15715; }","duration":"115.337519ms","start":"2026-09-01T04:52:23.055917Z","end":"2026-09-01T04:52:23.171254Z","steps":["trace[1422288069] 'read index received' (duration: 60.543298ms)","trace[1422288069] 'applied index is now lower than readState.Index' (duration: 54.792561ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:52:23.171349Z","caller":"traceutil/trace.go:171","msg":"trace[1093611240] transaction","detail":"{read_only:false; response_revision:15180; number_of_response:1; }","duration":"132.813886ms","start":"2026-09-01T04:52:23.038506Z","end":"2026-09-01T04:52:23.17132Z","steps":["trace[1093611240] 'process raft request' (duration: 78.016005ms)","trace[1093611240] 'compare' (duration: 54.558475ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:52:23.171644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.680349ms","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-09-01T04:52:23.171688Z","caller":"traceutil/trace.go:171","msg":"trace[1948770184] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15180; }","duration":"115.795102ms","start":"2026-09-01T04:52:23.055881Z","end":"2026-09-01T04:52:23.171676Z","steps":["trace[1948770184] 'agreement among raft nodes before linearized reading' (duration: 115.478343ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:52:39.1706Z","caller":"traceutil/trace.go:171","msg":"trace[1523954566] linearizableReadLoop","detail":"{readStateIndex:15941; appliedIndex:15940; }","duration":"127.77311ms","start":"2026-09-01T04:52:39.042802Z","end":"2026-09-01T04:52:39.170575Z","steps":["trace[1523954566] 'read index received' (duration: 127.527133ms)","trace[1523954566] 'applied index is now lower than readState.Index' (duration: 244.777µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:52:39.170637Z","caller":"traceutil/trace.go:171","msg":"trace[490928415] transaction","detail":"{read_only:false; response_revision:15400; number_of_response:1; }","duration":"138.631906ms","start":"2026-09-01T04:52:39.031966Z","end":"2026-09-01T04:52:39.170598Z","steps":["trace[490928415] 'process raft request' (duration: 138.43284ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:52:39.170955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.13628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-ac36a62d-3c86-4d50-bfb1-97f7d3eb55e0\" ","response":"range_response_count:1 size:1315"} {"level":"info","ts":"2026-09-01T04:52:39.171023Z","caller":"traceutil/trace.go:171","msg":"trace[1888872084] range","detail":"{range_begin:/registry/persistentvolumes/pvc-ac36a62d-3c86-4d50-bfb1-97f7d3eb55e0; range_end:; response_count:1; response_revision:15400; }","duration":"128.234214ms","start":"2026-09-01T04:52:39.042768Z","end":"2026-09-01T04:52:39.171002Z","steps":["trace[1888872084] 'agreement among raft nodes before linearized reading' (duration: 127.956376ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:53:26.967546Z","caller":"traceutil/trace.go:171","msg":"trace[1990198589] transaction","detail":"{read_only:false; response_revision:15985; number_of_response:1; }","duration":"112.129038ms","start":"2026-09-01T04:53:26.855385Z","end":"2026-09-01T04:53:26.967514Z","steps":["trace[1990198589] 'process raft request' (duration: 104.650532ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:54:00.581562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.464231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-mhgpf\" ","response":"range_response_count:1 size:6445"} {"level":"info","ts":"2026-09-01T04:54:00.581629Z","caller":"traceutil/trace.go:171","msg":"trace[12885112] range","detail":"{range_begin:/registry/pods/openstack/keepalived-mhgpf; range_end:; response_count:1; response_revision:16161; }","duration":"224.564214ms","start":"2026-09-01T04:54:00.35705Z","end":"2026-09-01T04:54:00.581614Z","steps":["trace[12885112] 'range keys from in-memory index tree' (duration: 224.349218ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:54:00.581813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.725059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"} {"level":"info","ts":"2026-09-01T04:54:00.581834Z","caller":"traceutil/trace.go:171","msg":"trace[631663052] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16161; }","duration":"215.760589ms","start":"2026-09-01T04:54:00.366067Z","end":"2026-09-01T04:54:00.581828Z","steps":["trace[631663052] 'range keys from in-memory index tree' (duration: 215.658447ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:54:00.581914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.936675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:54:00.58193Z","caller":"traceutil/trace.go:171","msg":"trace[1308842018] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16161; }","duration":"216.011997ms","start":"2026-09-01T04:54:00.365913Z","end":"2026-09-01T04:54:00.581925Z","steps":["trace[1308842018] 'range keys from in-memory index tree' (duration: 215.75546ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:54:00.582015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.681018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"} {"level":"info","ts":"2026-09-01T04:54:00.582037Z","caller":"traceutil/trace.go:171","msg":"trace[1751314692] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16161; }","duration":"215.714418ms","start":"2026-09-01T04:54:00.366316Z","end":"2026-09-01T04:54:00.58203Z","steps":["trace[1751314692] 'range keys from in-memory index tree' (duration: 215.625406ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:54:00.582598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.982812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"} {"level":"info","ts":"2026-09-01T04:54:00.582651Z","caller":"traceutil/trace.go:171","msg":"trace[1693600865] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16161; }","duration":"131.066075ms","start":"2026-09-01T04:54:00.451571Z","end":"2026-09-01T04:54:00.582637Z","steps":["trace[1693600865] 'range keys from in-memory index tree' (duration: 130.862348ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:54:00.58294Z","caller":"traceutil/trace.go:171","msg":"trace[1307093905] transaction","detail":"{read_only:false; response_revision:16162; number_of_response:1; }","duration":"129.610022ms","start":"2026-09-01T04:54:00.453281Z","end":"2026-09-01T04:54:00.582891Z","steps":["trace[1307093905] 'process raft request' (duration: 110.224032ms)","trace[1307093905] 'compare' (duration: 18.842954ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:54:05.988264Z","caller":"traceutil/trace.go:171","msg":"trace[860282160] linearizableReadLoop","detail":"{readStateIndex:16751; appliedIndex:16750; }","duration":"181.701827ms","start":"2026-09-01T04:54:05.806539Z","end":"2026-09-01T04:54:05.988241Z","steps":["trace[860282160] 'read index received' (duration: 84.276524ms)","trace[860282160] 'applied index is now lower than readState.Index' (duration: 97.423932ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:54:05.988377Z","caller":"traceutil/trace.go:171","msg":"trace[1296193429] transaction","detail":"{read_only:false; response_revision:16189; number_of_response:1; }","duration":"208.414616ms","start":"2026-09-01T04:54:05.779922Z","end":"2026-09-01T04:54:05.988337Z","steps":["trace[1296193429] 'process raft request' (duration: 110.88573ms)","trace[1296193429] 'compare' (duration: 97.242168ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:54:05.988502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.716582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-nsbph\" ","response":"range_response_count:1 size:20558"} {"level":"info","ts":"2026-09-01T04:54:05.988539Z","caller":"traceutil/trace.go:171","msg":"trace[880904811] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-nsbph; range_end:; response_count:1; response_revision:16189; }","duration":"159.784584ms","start":"2026-09-01T04:54:05.828745Z","end":"2026-09-01T04:54:05.98853Z","steps":["trace[880904811] 'agreement among raft nodes before linearized reading' (duration: 159.66736ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:54:05.988415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.870901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:54:05.98864Z","caller":"traceutil/trace.go:171","msg":"trace[1950562467] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:16189; }","duration":"182.141999ms","start":"2026-09-01T04:54:05.806486Z","end":"2026-09-01T04:54:05.988628Z","steps":["trace[1950562467] 'agreement among raft nodes before linearized reading' (duration: 181.880141ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:54:06.467986Z","caller":"traceutil/trace.go:171","msg":"trace[291447453] linearizableReadLoop","detail":"{readStateIndex:16755; appliedIndex:16754; }","duration":"110.705347ms","start":"2026-09-01T04:54:06.357254Z","end":"2026-09-01T04:54:06.46796Z","steps":["trace[291447453] 'read index received' (duration: 6.065825ms)","trace[291447453] 'applied index is now lower than readState.Index' (duration: 104.638192ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:54:06.468068Z","caller":"traceutil/trace.go:171","msg":"trace[62223361] transaction","detail":"{read_only:false; response_revision:16193; number_of_response:1; }","duration":"113.350443ms","start":"2026-09-01T04:54:06.354683Z","end":"2026-09-01T04:54:06.468033Z","steps":["trace[62223361] 'process raft request' (duration: 106.026641ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:54:06.468434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.142799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"} {"level":"warn","ts":"2026-09-01T04:54:06.468499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.197921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:54:06.46855Z","caller":"traceutil/trace.go:171","msg":"trace[1556153217] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16193; }","duration":"111.313684ms","start":"2026-09-01T04:54:06.357223Z","end":"2026-09-01T04:54:06.468537Z","steps":["trace[1556153217] 'agreement among raft nodes before linearized reading' (duration: 110.893272ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:54:06.468549Z","caller":"traceutil/trace.go:171","msg":"trace[721488827] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16193; }","duration":"111.296993ms","start":"2026-09-01T04:54:06.357233Z","end":"2026-09-01T04:54:06.46853Z","steps":["trace[721488827] 'agreement among raft nodes before linearized reading' (duration: 110.977964ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:54:06.468586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.282183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"} {"level":"info","ts":"2026-09-01T04:54:06.468786Z","caller":"traceutil/trace.go:171","msg":"trace[669819949] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16193; }","duration":"111.499079ms","start":"2026-09-01T04:54:06.357274Z","end":"2026-09-01T04:54:06.468773Z","steps":["trace[669819949] 'agreement among raft nodes before linearized reading' (duration: 110.933983ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:54:06.931805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.015837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"} {"level":"info","ts":"2026-09-01T04:54:06.931906Z","caller":"traceutil/trace.go:171","msg":"trace[1675645096] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16193; }","duration":"331.145521ms","start":"2026-09-01T04:54:06.600726Z","end":"2026-09-01T04:54:06.931872Z","steps":["trace[1675645096] 'range keys from in-memory index tree' (duration: 330.858963ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:54:06.931949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:54:06.600707Z","time spent":"331.231094ms","remote":"127.0.0.1:44824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":690,"request content":"key:\"/registry/services/endpoints/openstack/nova-api\" "} {"level":"warn","ts":"2026-09-01T04:54:06.93227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.261634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"} {"level":"info","ts":"2026-09-01T04:54:06.932325Z","caller":"traceutil/trace.go:171","msg":"trace[1002093067] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16193; }","duration":"331.333507ms","start":"2026-09-01T04:54:06.600978Z","end":"2026-09-01T04:54:06.932312Z","steps":["trace[1002093067] 'range keys from in-memory index tree' (duration: 331.176621ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:54:06.932355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:54:06.600972Z","time spent":"331.376528ms","remote":"127.0.0.1:44898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5471,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "} {"level":"warn","ts":"2026-09-01T04:54:06.932671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.56943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:54:06.93273Z","caller":"traceutil/trace.go:171","msg":"trace[1664046147] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16193; }","duration":"316.667583ms","start":"2026-09-01T04:54:06.616049Z","end":"2026-09-01T04:54:06.932716Z","steps":["trace[1664046147] 'range keys from in-memory index tree' (duration: 316.461836ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:54:06.932768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:54:06.616025Z","time spent":"316.731964ms","remote":"127.0.0.1:44898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/nova-rabbit-init\" "} {"level":"warn","ts":"2026-09-01T04:54:06.933029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.724105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"} {"level":"info","ts":"2026-09-01T04:54:06.933068Z","caller":"traceutil/trace.go:171","msg":"trace[1315838591] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16193; }","duration":"316.788646ms","start":"2026-09-01T04:54:06.61627Z","end":"2026-09-01T04:54:06.933059Z","steps":["trace[1315838591] 'range keys from in-memory index tree' (duration: 316.646663ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:54:06.933087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:54:06.616261Z","time spent":"316.821007ms","remote":"127.0.0.1:44824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":690,"request content":"key:\"/registry/services/endpoints/openstack/nova-api\" "} {"level":"warn","ts":"2026-09-01T04:54:06.934443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.411388ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T04:54:06.934838Z","caller":"traceutil/trace.go:171","msg":"trace[1422541580] transaction","detail":"{read_only:false; response_revision:16194; number_of_response:1; }","duration":"314.035147ms","start":"2026-09-01T04:54:06.620772Z","end":"2026-09-01T04:54:06.934807Z","steps":["trace[1422541580] 'process raft request' (duration: 166.878098ms)","trace[1422541580] 'compare' (duration: 145.299275ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:54:06.934983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:54:06.620749Z","time spent":"314.159381ms","remote":"127.0.0.1:44920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T04:54:06.934855Z","caller":"traceutil/trace.go:171","msg":"trace[46723523] linearizableReadLoop","detail":"{readStateIndex:16756; appliedIndex:16755; }","duration":"278.049687ms","start":"2026-09-01T04:54:06.656784Z","end":"2026-09-01T04:54:06.934834Z","steps":["trace[46723523] 'read index received' (duration: 130.868018ms)","trace[46723523] 'applied index is now lower than readState.Index' (duration: 147.179119ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:54:06.936476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.663615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-mhgpf\" ","response":"range_response_count:1 size:6445"} {"level":"info","ts":"2026-09-01T04:54:06.936721Z","caller":"traceutil/trace.go:171","msg":"trace[1843133760] range","detail":"{range_begin:/registry/pods/openstack/keepalived-mhgpf; range_end:; response_count:1; response_revision:16194; }","duration":"279.959173ms","start":"2026-09-01T04:54:06.656749Z","end":"2026-09-01T04:54:06.936709Z","steps":["trace[1843133760] 'agreement among raft nodes before linearized reading' (duration: 278.14199ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:56:18.450167Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14619} {"level":"info","ts":"2026-09-01T04:56:18.542746Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14619,"took":"89.895376ms","hash":2172485778,"current-db-size-bytes":57417728,"current-db-size":"57 MB","current-db-size-in-use-bytes":32051200,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-09-01T04:56:18.542798Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2172485778,"revision":14619,"compact-revision":12598} {"level":"info","ts":"2026-09-01T04:59:35.164493Z","caller":"traceutil/trace.go:171","msg":"trace[531269717] linearizableReadLoop","detail":"{readStateIndex:19245; appliedIndex:19244; }","duration":"160.749329ms","start":"2026-09-01T04:59:35.00372Z","end":"2026-09-01T04:59:35.16447Z","steps":["trace[531269717] 'read index received' (duration: 146.829548ms)","trace[531269717] 'applied index is now lower than readState.Index' (duration: 13.918591ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:59:35.165131Z","caller":"traceutil/trace.go:171","msg":"trace[1284393929] transaction","detail":"{read_only:false; response_revision:18600; number_of_response:1; }","duration":"163.355277ms","start":"2026-09-01T04:59:35.001732Z","end":"2026-09-01T04:59:35.165087Z","steps":["trace[1284393929] 'process raft request' (duration: 148.805517ms)","trace[1284393929] 'compare' (duration: 13.628312ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:59:35.165146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.388419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1286"} {"level":"warn","ts":"2026-09-01T04:59:35.165203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.519578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-09-01T04:59:35.165259Z","caller":"traceutil/trace.go:171","msg":"trace[1116376674] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18600; }","duration":"149.59278ms","start":"2026-09-01T04:59:35.015652Z","end":"2026-09-01T04:59:35.165245Z","steps":["trace[1116376674] 'agreement among raft nodes before linearized reading' (duration: 149.399795ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:59:35.165254Z","caller":"traceutil/trace.go:171","msg":"trace[584391564] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:18600; }","duration":"161.522193ms","start":"2026-09-01T04:59:35.003701Z","end":"2026-09-01T04:59:35.165224Z","steps":["trace[584391564] 'agreement among raft nodes before linearized reading' (duration: 161.223544ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:59:35.406651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.198683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:994"} {"level":"info","ts":"2026-09-01T04:59:35.406778Z","caller":"traceutil/trace.go:171","msg":"trace[1573630485] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:18601; }","duration":"142.383348ms","start":"2026-09-01T04:59:35.264369Z","end":"2026-09-01T04:59:35.406752Z","steps":["trace[1573630485] 'range keys from in-memory index tree' (duration: 141.927415ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:59:35.406684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.495084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4727"} {"level":"info","ts":"2026-09-01T04:59:35.407027Z","caller":"traceutil/trace.go:171","msg":"trace[503507111] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:18601; }","duration":"138.877465ms","start":"2026-09-01T04:59:35.268125Z","end":"2026-09-01T04:59:35.407002Z","steps":["trace[503507111] 'range keys from in-memory index tree' (duration: 138.303167ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:59:36.906186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.16675ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-09-01T04:59:36.906347Z","caller":"traceutil/trace.go:171","msg":"trace[1289041029] linearizableReadLoop","detail":"{readStateIndex:19264; appliedIndex:19263; }","duration":"170.994194ms","start":"2026-09-01T04:59:36.735327Z","end":"2026-09-01T04:59:36.906321Z","steps":["trace[1289041029] 'read index received' (duration: 69.551156ms)","trace[1289041029] 'applied index is now lower than readState.Index' (duration: 101.440618ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:59:36.906586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.239591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:703"} {"level":"info","ts":"2026-09-01T04:59:36.906629Z","caller":"traceutil/trace.go:171","msg":"trace[686823029] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18618; }","duration":"171.287262ms","start":"2026-09-01T04:59:36.73532Z","end":"2026-09-01T04:59:36.906608Z","steps":["trace[686823029] 'agreement among raft nodes before linearized reading' (duration: 171.075766ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:59:41.795295Z","caller":"traceutil/trace.go:171","msg":"trace[1903010475] transaction","detail":"{read_only:false; response_revision:18660; number_of_response:1; }","duration":"117.724539ms","start":"2026-09-01T04:59:41.677541Z","end":"2026-09-01T04:59:41.795265Z","steps":["trace[1903010475] 'process raft request' (duration: 41.490056ms)","trace[1903010475] 'compare' (duration: 76.033087ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:59:42.24347Z","caller":"traceutil/trace.go:171","msg":"trace[1313565089] transaction","detail":"{read_only:false; response_revision:18663; number_of_response:1; }","duration":"222.084504ms","start":"2026-09-01T04:59:42.02136Z","end":"2026-09-01T04:59:42.243445Z","steps":["trace[1313565089] 'process raft request' (duration: 202.218197ms)","trace[1313565089] 'compare' (duration: 19.719973ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:59:42.649384Z","caller":"traceutil/trace.go:171","msg":"trace[1455061247] transaction","detail":"{read_only:false; response_revision:18664; number_of_response:1; }","duration":"625.640459ms","start":"2026-09-01T04:59:42.023715Z","end":"2026-09-01T04:59:42.649355Z","steps":["trace[1455061247] 'process raft request' (duration: 625.468234ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:59:42.649552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:59:42.023698Z","time spent":"625.778204ms","remote":"127.0.0.1:44920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T04:59:42.649613Z","caller":"traceutil/trace.go:171","msg":"trace[1791861988] linearizableReadLoop","detail":"{readStateIndex:19312; appliedIndex:19309; }","duration":"596.326513ms","start":"2026-09-01T04:59:42.053258Z","end":"2026-09-01T04:59:42.649584Z","steps":["trace[1791861988] 'read index received' (duration: 170.423547ms)","trace[1791861988] 'applied index is now lower than readState.Index' (duration: 425.901926ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:59:42.649873Z","caller":"traceutil/trace.go:171","msg":"trace[811788061] transaction","detail":"{read_only:false; response_revision:18666; number_of_response:1; }","duration":"442.105785ms","start":"2026-09-01T04:59:42.207754Z","end":"2026-09-01T04:59:42.64986Z","steps":["trace[811788061] 'process raft request' (duration: 441.751025ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:59:42.649966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:59:42.20773Z","time spent":"442.177237ms","remote":"127.0.0.1:44920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T04:59:42.649994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.718004ms","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-09-01T04:59:42.650063Z","caller":"traceutil/trace.go:171","msg":"trace[1117629390] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18666; }","duration":"596.819637ms","start":"2026-09-01T04:59:42.053224Z","end":"2026-09-01T04:59:42.650044Z","steps":["trace[1117629390] 'agreement among raft nodes before linearized reading' (duration: 596.656173ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:59:42.650095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:59:42.05321Z","time spent":"596.87691ms","remote":"127.0.0.1:44920","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":"info","ts":"2026-09-01T04:59:42.650082Z","caller":"traceutil/trace.go:171","msg":"trace[1240031061] transaction","detail":"{read_only:false; response_revision:18665; number_of_response:1; }","duration":"626.055691ms","start":"2026-09-01T04:59:42.023889Z","end":"2026-09-01T04:59:42.649944Z","steps":["trace[1240031061] 'process raft request' (duration: 625.427033ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:59:42.650206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:59:42.023884Z","time spent":"626.249007ms","remote":"127.0.0.1:44920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T04:59:42.668216Z","caller":"traceutil/trace.go:171","msg":"trace[247650395] transaction","detail":"{read_only:false; response_revision:18667; number_of_response:1; }","duration":"333.439145ms","start":"2026-09-01T04:59:42.334748Z","end":"2026-09-01T04:59:42.668187Z","steps":["trace[247650395] 'process raft request' (duration: 333.293941ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:59:42.668342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:59:42.334725Z","time spent":"333.547807ms","remote":"127.0.0.1:44920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T04:59:42.668583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.589761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-01T04:59:42.668691Z","caller":"traceutil/trace.go:171","msg":"trace[1554964058] range","detail":"{range_begin:/registry/objectbucket.io/objectbuckets/; range_end:/registry/objectbucket.io/objectbuckets0; response_count:0; response_revision:18668; }","duration":"551.731765ms","start":"2026-09-01T04:59:42.116937Z","end":"2026-09-01T04:59:42.668669Z","steps":["trace[1554964058] 'agreement among raft nodes before linearized reading' (duration: 551.495648ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:59:42.668794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.314526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-01T04:59:42.668913Z","caller":"traceutil/trace.go:171","msg":"trace[1858986485] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:18668; }","duration":"321.468031ms","start":"2026-09-01T04:59:42.347429Z","end":"2026-09-01T04:59:42.668897Z","steps":["trace[1858986485] 'agreement among raft nodes before linearized reading' (duration: 321.229944ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:59:42.669009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:59:42.347411Z","time spent":"321.581864ms","remote":"127.0.0.1:35182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-09-01T04:59:42.669466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.724321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:703"} {"level":"info","ts":"2026-09-01T04:59:42.669686Z","caller":"traceutil/trace.go:171","msg":"trace[378277233] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18668; }","duration":"423.967429ms","start":"2026-09-01T04:59:42.245699Z","end":"2026-09-01T04:59:42.669666Z","steps":["trace[378277233] 'agreement among raft nodes before linearized reading' (duration: 423.66961ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:59:42.669885Z","caller":"traceutil/trace.go:171","msg":"trace[1710484824] transaction","detail":"{read_only:false; response_revision:18668; number_of_response:1; }","duration":"147.897951ms","start":"2026-09-01T04:59:42.521974Z","end":"2026-09-01T04:59:42.669872Z","steps":["trace[1710484824] 'process raft request' (duration: 146.18087ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:59:42.669846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:59:42.245687Z","time spent":"424.141204ms","remote":"127.0.0.1:44824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":726,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "} {"level":"warn","ts":"2026-09-01T04:59:42.670912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:59:42.116923Z","time spent":"551.802387ms","remote":"127.0.0.1:58350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":29,"request content":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" count_only:true "} {"level":"info","ts":"2026-09-01T04:59:51.464431Z","caller":"traceutil/trace.go:171","msg":"trace[1204788601] transaction","detail":"{read_only:false; response_revision:18775; number_of_response:1; }","duration":"126.018413ms","start":"2026-09-01T04:59:51.33839Z","end":"2026-09-01T04:59:51.464408Z","steps":["trace[1204788601] 'process raft request' (duration: 125.888039ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:59:51.471706Z","caller":"traceutil/trace.go:171","msg":"trace[348478709] transaction","detail":"{read_only:false; response_revision:18776; number_of_response:1; }","duration":"131.090593ms","start":"2026-09-01T04:59:51.340589Z","end":"2026-09-01T04:59:51.471679Z","steps":["trace[348478709] 'process raft request' (duration: 130.930508ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:59:51.471887Z","caller":"traceutil/trace.go:171","msg":"trace[77094635] linearizableReadLoop","detail":"{readStateIndex:19427; appliedIndex:19425; }","duration":"125.624771ms","start":"2026-09-01T04:59:51.346233Z","end":"2026-09-01T04:59:51.471858Z","steps":["trace[77094635] 'read index received' (duration: 118.422988ms)","trace[77094635] 'applied index is now lower than readState.Index' (duration: 7.199773ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:59:51.471909Z","caller":"traceutil/trace.go:171","msg":"trace[2074361115] transaction","detail":"{read_only:false; number_of_response:1; response_revision:18776; }","duration":"131.064092ms","start":"2026-09-01T04:59:51.340814Z","end":"2026-09-01T04:59:51.471878Z","steps":["trace[2074361115] 'process raft request' (duration: 130.837445ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:59:51.472232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.736806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1344"} {"level":"warn","ts":"2026-09-01T04:59:51.472229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.91192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4727"} {"level":"info","ts":"2026-09-01T04:59:51.472304Z","caller":"traceutil/trace.go:171","msg":"trace[1709355699] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:18776; }","duration":"126.091295ms","start":"2026-09-01T04:59:51.346197Z","end":"2026-09-01T04:59:51.472288Z","steps":["trace[1709355699] 'agreement among raft nodes before linearized reading' (duration: 125.777296ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:59:51.472278Z","caller":"traceutil/trace.go:171","msg":"trace[1950269729] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:18776; }","duration":"119.85299ms","start":"2026-09-01T04:59:51.352412Z","end":"2026-09-01T04:59:51.472265Z","steps":["trace[1950269729] 'agreement among raft nodes before linearized reading' (duration: 119.594963ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:59:51.472947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.41924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2225409"} {"level":"info","ts":"2026-09-01T04:59:51.473025Z","caller":"traceutil/trace.go:171","msg":"trace[1231957750] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:18776; }","duration":"112.521322ms","start":"2026-09-01T04:59:51.360484Z","end":"2026-09-01T04:59:51.473005Z","steps":["trace[1231957750] 'agreement among raft nodes before linearized reading' (duration: 111.595485ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:00:36.834727Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"2f0e00eb3c3ee1b","local-member-applied-index":20005,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-01T05:00:36.854604Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20005} {"level":"info","ts":"2026-09-01T05:00:36.85471Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15005} {"level":"info","ts":"2026-09-01T05:01:18.464569Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17103} {"level":"info","ts":"2026-09-01T05:01:18.588667Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17103,"took":"121.761236ms","hash":3429496404,"current-db-size-bytes":57417728,"current-db-size":"57 MB","current-db-size-in-use-bytes":34099200,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-09-01T05:01:18.588838Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3429496404,"revision":17103,"compact-revision":14619} {"level":"warn","ts":"2026-09-01T05:05:45.269868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.550457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-01T05:05:45.26996Z","caller":"traceutil/trace.go:171","msg":"trace[156715371] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:21559; }","duration":"145.864706ms","start":"2026-09-01T05:05:45.124066Z","end":"2026-09-01T05:05:45.26993Z","steps":["trace[156715371] 'count revisions from in-memory index tree' (duration: 145.443603ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:05:50.664955Z","caller":"traceutil/trace.go:171","msg":"trace[1982248772] transaction","detail":"{read_only:false; response_revision:21587; number_of_response:1; }","duration":"128.458659ms","start":"2026-09-01T05:05:50.536469Z","end":"2026-09-01T05:05:50.664928Z","steps":["trace[1982248772] 'process raft request' (duration: 128.229603ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:05:51.038087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.338456ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-01T05:05:51.038204Z","caller":"traceutil/trace.go:171","msg":"trace[736966590] transaction","detail":"{read_only:false; response_revision:21588; number_of_response:1; }","duration":"359.204933ms","start":"2026-09-01T05:05:50.678979Z","end":"2026-09-01T05:05:51.038184Z","steps":["trace[736966590] 'process raft request' (duration: 234.695151ms)","trace[736966590] 'compare' (duration: 123.963426ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T05:05:51.03826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T05:05:50.678955Z","time spent":"359.278214ms","remote":"127.0.0.1:44920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T05:05:51.049647Z","caller":"traceutil/trace.go:171","msg":"trace[460924590] linearizableReadLoop","detail":"{readStateIndex:22329; appliedIndex:22327; }","duration":"326.294256ms","start":"2026-09-01T05:05:50.723324Z","end":"2026-09-01T05:05:51.049619Z","steps":["trace[460924590] 'read index received' (duration: 190.363785ms)","trace[460924590] 'applied index is now lower than readState.Index' (duration: 135.929411ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T05:05:51.049749Z","caller":"traceutil/trace.go:171","msg":"trace[540876768] transaction","detail":"{read_only:false; response_revision:21589; number_of_response:1; }","duration":"370.276761ms","start":"2026-09-01T05:05:50.679453Z","end":"2026-09-01T05:05:51.04973Z","steps":["trace[540876768] 'process raft request' (duration: 370.013823ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:05:51.049875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T05:05:50.679425Z","time spent":"370.380683ms","remote":"127.0.0.1:44920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T05:05:51.049978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.629966ms","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-09-01T05:05:51.050053Z","caller":"traceutil/trace.go:171","msg":"trace[1858066205] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21589; }","duration":"326.720619ms","start":"2026-09-01T05:05:50.723312Z","end":"2026-09-01T05:05:51.050032Z","steps":["trace[1858066205] 'agreement among raft nodes before linearized reading' (duration: 326.456411ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:05:51.050106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T05:05:50.72326Z","time spent":"326.833722ms","remote":"127.0.0.1:44920","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-09-01T05:05:51.050079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.485511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-01T05:05:51.050232Z","caller":"traceutil/trace.go:171","msg":"trace[1806563640] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21589; }","duration":"241.737249ms","start":"2026-09-01T05:05:50.80848Z","end":"2026-09-01T05:05:51.050217Z","steps":["trace[1806563640] 'agreement among raft nodes before linearized reading' (duration: 241.489551ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:05:51.313893Z","caller":"traceutil/trace.go:171","msg":"trace[838870375] transaction","detail":"{read_only:false; response_revision:21591; number_of_response:1; }","duration":"146.267698ms","start":"2026-09-01T05:05:51.167607Z","end":"2026-09-01T05:05:51.313875Z","steps":["trace[838870375] 'process raft request' (duration: 146.141884ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:05:51.313954Z","caller":"traceutil/trace.go:171","msg":"trace[2141853272] linearizableReadLoop","detail":"{readStateIndex:22330; appliedIndex:22329; }","duration":"231.145055ms","start":"2026-09-01T05:05:51.082796Z","end":"2026-09-01T05:05:51.313941Z","steps":["trace[2141853272] 'read index received' (duration: 143.573418ms)","trace[2141853272] 'applied index is now lower than readState.Index' (duration: 87.569607ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T05:05:51.313874Z","caller":"traceutil/trace.go:171","msg":"trace[80451276] transaction","detail":"{read_only:false; response_revision:21590; number_of_response:1; }","duration":"259.752544ms","start":"2026-09-01T05:05:51.054056Z","end":"2026-09-01T05:05:51.313809Z","steps":["trace[80451276] 'process raft request' (duration: 172.214338ms)","trace[80451276] 'compare' (duration: 87.199186ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T05:05:51.314146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.32773ms","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-09-01T05:05:51.314208Z","caller":"traceutil/trace.go:171","msg":"trace[797746227] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:21591; }","duration":"231.413133ms","start":"2026-09-01T05:05:51.082782Z","end":"2026-09-01T05:05:51.314195Z","steps":["trace[797746227] 'agreement among raft nodes before linearized reading' (duration: 231.208567ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:05:51.680809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.536085ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-01T05:05:51.680961Z","caller":"traceutil/trace.go:171","msg":"trace[2100150184] transaction","detail":"{read_only:false; response_revision:21592; number_of_response:1; }","duration":"361.064069ms","start":"2026-09-01T05:05:51.319873Z","end":"2026-09-01T05:05:51.680937Z","steps":["trace[2100150184] 'process raft request' (duration: 181.311188ms)","trace[2100150184] 'compare' (duration: 179.180814ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T05:05:51.681041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T05:05:51.319846Z","time spent":"361.165182ms","remote":"127.0.0.1:44920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T05:05:51.695442Z","caller":"traceutil/trace.go:171","msg":"trace[951194069] transaction","detail":"{read_only:false; response_revision:21593; number_of_response:1; }","duration":"327.925766ms","start":"2026-09-01T05:05:51.36747Z","end":"2026-09-01T05:05:51.695396Z","steps":["trace[951194069] 'process raft request' (duration: 327.579865ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:05:51.695592Z","caller":"traceutil/trace.go:171","msg":"trace[1198541546] linearizableReadLoop","detail":"{readStateIndex:22333; appliedIndex:22332; }","duration":"157.860822ms","start":"2026-09-01T05:05:51.53747Z","end":"2026-09-01T05:05:51.69533Z","steps":["trace[1198541546] 'read index received' (duration: 157.46323ms)","trace[1198541546] 'applied index is now lower than readState.Index' (duration: 396.432µs)"],"step_count":2} {"level":"warn","ts":"2026-09-01T05:05:51.695658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T05:05:51.367446Z","time spent":"328.102661ms","remote":"127.0.0.1:44920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T05:05:51.69599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.070154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-01T05:05:51.696069Z","caller":"traceutil/trace.go:171","msg":"trace[1951492818] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:21593; }","duration":"138.193359ms","start":"2026-09-01T05:05:51.557857Z","end":"2026-09-01T05:05:51.696051Z","steps":["trace[1951492818] 'agreement among raft nodes before linearized reading' (duration: 138.043144ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:05:51.696059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.551062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-09-01T05:05:51.696134Z","caller":"traceutil/trace.go:171","msg":"trace[1682835711] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:21593; }","duration":"158.688257ms","start":"2026-09-01T05:05:51.537429Z","end":"2026-09-01T05:05:51.696117Z","steps":["trace[1682835711] 'agreement among raft nodes before linearized reading' (duration: 158.353937ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:05:52.038605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.581759ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"warn","ts":"2026-09-01T05:05:52.039087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T05:05:51.698223Z","time spent":"340.85925ms","remote":"127.0.0.1:44704","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-09-01T05:05:52.03919Z","caller":"traceutil/trace.go:171","msg":"trace[1927685104] transaction","detail":"{read_only:false; response_revision:21594; number_of_response:1; }","duration":"334.879222ms","start":"2026-09-01T05:05:51.704287Z","end":"2026-09-01T05:05:52.039166Z","steps":["trace[1927685104] 'process raft request' (duration: 334.45621ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:05:52.039168Z","caller":"traceutil/trace.go:171","msg":"trace[341652508] linearizableReadLoop","detail":"{readStateIndex:22336; appliedIndex:22333; }","duration":"230.109814ms","start":"2026-09-01T05:05:51.809024Z","end":"2026-09-01T05:05:52.039134Z","steps":["trace[341652508] 'read index received' (duration: 59.126073ms)","trace[341652508] 'applied index is now lower than readState.Index' (duration: 170.979601ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T05:05:52.039205Z","caller":"traceutil/trace.go:171","msg":"trace[1446536539] transaction","detail":"{read_only:false; response_revision:21595; number_of_response:1; }","duration":"303.258755ms","start":"2026-09-01T05:05:51.735887Z","end":"2026-09-01T05:05:52.039146Z","steps":["trace[1446536539] 'process raft request' (duration: 303.059269ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:05:52.039371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T05:05:51.704259Z","time spent":"335.028036ms","remote":"127.0.0.1:44920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T05:05:52.039372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.30951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-01T05:05:52.039439Z","caller":"traceutil/trace.go:171","msg":"trace[860444515] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21595; }","duration":"230.423704ms","start":"2026-09-01T05:05:51.808992Z","end":"2026-09-01T05:05:52.039416Z","steps":["trace[860444515] 'agreement among raft nodes before linearized reading' (duration: 230.28565ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:05:52.039525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T05:05:51.73586Z","time spent":"303.511461ms","remote":"127.0.0.1:44920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T05:05:52.039735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.983584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"warn","ts":"2026-09-01T05:05:52.039751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.976352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-01T05:05:52.039775Z","caller":"traceutil/trace.go:171","msg":"trace[1730369484] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:21595; }","duration":"133.049636ms","start":"2026-09-01T05:05:51.906714Z","end":"2026-09-01T05:05:52.039764Z","steps":["trace[1730369484] 'agreement among raft nodes before linearized reading' (duration: 132.962343ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:05:52.039809Z","caller":"traceutil/trace.go:171","msg":"trace[1641236798] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:21595; }","duration":"137.076446ms","start":"2026-09-01T05:05:51.902717Z","end":"2026-09-01T05:05:52.039793Z","steps":["trace[1641236798] 'agreement among raft nodes before linearized reading' (duration: 136.943002ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:05:52.28914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.354598ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-01T05:05:52.289245Z","caller":"traceutil/trace.go:171","msg":"trace[453979443] transaction","detail":"{read_only:false; response_revision:21597; number_of_response:1; }","duration":"152.010749ms","start":"2026-09-01T05:05:52.137211Z","end":"2026-09-01T05:05:52.289222Z","steps":["trace[453979443] 'process raft request' (duration: 27.500016ms)","trace[453979443] 'compare' (duration: 124.062549ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T05:05:52.306613Z","caller":"traceutil/trace.go:171","msg":"trace[1027980707] transaction","detail":"{read_only:false; response_revision:21598; number_of_response:1; }","duration":"101.425738ms","start":"2026-09-01T05:05:52.20516Z","end":"2026-09-01T05:05:52.306585Z","steps":["trace[1027980707] 'process raft request' (duration: 101.17853ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:06:18.472153Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19692} {"level":"info","ts":"2026-09-01T05:06:18.59616Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19692,"took":"120.49819ms","hash":1339558063,"current-db-size-bytes":57417728,"current-db-size":"57 MB","current-db-size-in-use-bytes":30056448,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-09-01T05:06:18.596219Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1339558063,"revision":19692,"compact-revision":17103} {"level":"info","ts":"2026-09-01T05:09:54.743188Z","caller":"traceutil/trace.go:171","msg":"trace[2139178993] linearizableReadLoop","detail":"{readStateIndex:24902; appliedIndex:24902; }","duration":"337.595913ms","start":"2026-09-01T05:09:54.405553Z","end":"2026-09-01T05:09:54.743149Z","steps":["trace[2139178993] 'read index received' (duration: 337.585692ms)","trace[2139178993] 'applied index is now lower than readState.Index' (duration: 8.621µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T05:09:54.74335Z","caller":"traceutil/trace.go:171","msg":"trace[1481795870] transaction","detail":"{read_only:false; response_revision:24085; number_of_response:1; }","duration":"337.641384ms","start":"2026-09-01T05:09:54.405442Z","end":"2026-09-01T05:09:54.743083Z","steps":["trace[1481795870] 'process raft request' (duration: 337.488649ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:09:54.743466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T05:09:54.40543Z","time spent":"337.965813ms","remote":"127.0.0.1:44920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T05:09:54.743557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.944453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-09-01T05:09:54.743757Z","caller":"traceutil/trace.go:171","msg":"trace[276447116] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24085; }","duration":"338.19705ms","start":"2026-09-01T05:09:54.405539Z","end":"2026-09-01T05:09:54.743736Z","steps":["trace[276447116] 'agreement among raft nodes before linearized reading' (duration: 337.706506ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:09:54.744057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T05:09:54.405535Z","time spent":"338.387976ms","remote":"127.0.0.1:44920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-09-01T05:09:54.752691Z","caller":"traceutil/trace.go:171","msg":"trace[1835560703] transaction","detail":"{read_only:false; response_revision:24086; number_of_response:1; }","duration":"232.122337ms","start":"2026-09-01T05:09:54.520539Z","end":"2026-09-01T05:09:54.752661Z","steps":["trace[1835560703] 'process raft request' (duration: 231.953882ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:09:54.752739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.151275ms","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-09-01T05:09:54.752788Z","caller":"traceutil/trace.go:171","msg":"trace[1909277870] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24087; }","duration":"132.236168ms","start":"2026-09-01T05:09:54.620537Z","end":"2026-09-01T05:09:54.752773Z","steps":["trace[1909277870] 'agreement among raft nodes before linearized reading' (duration: 132.078543ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:10:51.03262Z","caller":"traceutil/trace.go:171","msg":"trace[933119101] transaction","detail":"{read_only:false; response_revision:24651; number_of_response:1; }","duration":"100.410605ms","start":"2026-09-01T05:10:50.932181Z","end":"2026-09-01T05:10:51.032592Z","steps":["trace[933119101] 'process raft request' (duration: 27.503862ms)","trace[933119101] 'compare' (duration: 72.759019ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T05:11:18.479005Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21734} {"level":"info","ts":"2026-09-01T05:11:18.600661Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21734,"took":"117.285434ms","hash":4906825,"current-db-size-bytes":57417728,"current-db-size":"57 MB","current-db-size-in-use-bytes":43589632,"current-db-size-in-use":"44 MB"} {"level":"info","ts":"2026-09-01T05:11:18.600738Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4906825,"revision":21734,"compact-revision":19692} {"level":"info","ts":"2026-09-01T05:13:36.080391Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006910.wal"} {"level":"info","ts":"2026-09-01T05:16:18.48576Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24994} {"level":"info","ts":"2026-09-01T05:16:18.721549Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24994,"took":"232.880036ms","hash":856105788,"current-db-size-bytes":57417728,"current-db-size":"57 MB","current-db-size-in-use-bytes":31461376,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-09-01T05:16:18.722428Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":856105788,"revision":24994,"compact-revision":21734} {"level":"warn","ts":"2026-09-01T05:17:07.911904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.845896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/local-path-storage/\" range_end:\"/registry/services/endpoints/local-path-storage0\" limit:500 ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-01T05:17:07.912038Z","caller":"traceutil/trace.go:171","msg":"trace[1041787955] range","detail":"{range_begin:/registry/services/endpoints/local-path-storage/; range_end:/registry/services/endpoints/local-path-storage0; response_count:0; response_revision:27604; }","duration":"112.030611ms","start":"2026-09-01T05:17:07.799978Z","end":"2026-09-01T05:17:07.912008Z","steps":["trace[1041787955] 'range keys from in-memory index tree' (duration: 111.777344ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:17:07.912312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.113042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:1 size:847"} {"level":"warn","ts":"2026-09-01T05:17:07.912394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.510066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/local-path-storage/\" range_end:\"/registry/ingress/local-path-storage0\" limit:500 ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-01T05:17:07.912533Z","caller":"traceutil/trace.go:171","msg":"trace[1794342973] range","detail":"{range_begin:/registry/ingress/local-path-storage/; range_end:/registry/ingress/local-path-storage0; response_count:0; response_revision:27604; }","duration":"110.707013ms","start":"2026-09-01T05:17:07.801785Z","end":"2026-09-01T05:17:07.912492Z","steps":["trace[1794342973] 'range keys from in-memory index tree' (duration: 110.429504ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:17:07.9125Z","caller":"traceutil/trace.go:171","msg":"trace[1640415930] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway; range_end:; response_count:1; response_revision:27604; }","duration":"174.282228ms","start":"2026-09-01T05:17:07.738112Z","end":"2026-09-01T05:17:07.912394Z","steps":["trace[1640415930] 'range keys from in-memory index tree' (duration: 173.883666ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T05:17:07.912793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.433593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:1 size:834"} {"level":"info","ts":"2026-09-01T05:17:07.912946Z","caller":"traceutil/trace.go:171","msg":"trace[1761125089] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:1; response_revision:27604; }","duration":"171.65623ms","start":"2026-09-01T05:17:07.741269Z","end":"2026-09-01T05:17:07.912926Z","steps":["trace[1761125089] 'range keys from in-memory index tree' (duration: 170.792954ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T05:20:21.66626Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"2f0e00eb3c3ee1b","local-member-applied-index":30006,"local-member-snapshot-index":20005,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-01T05:20:21.673443Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30006} {"level":"info","ts":"2026-09-01T05:20:21.673579Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25006}