{"level":"warn","ts":"2026-04-11T17:48:35.455427Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-11T17:48:35.455555Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.238:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.238:2380","--initial-cluster=instance=https://199.19.213.238:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.238:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.238: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-04-11T17:48:35.455645Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-11T17:48:35.455658Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.238:2380"]} {"level":"info","ts":"2026-04-11T17:48:35.455683Z","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-04-11T17:48:35.456441Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.238:2379"]} {"level":"info","ts":"2026-04-11T17:48:35.456534Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.238:2380"],"listen-peer-urls":["https://199.19.213.238:2380"],"advertise-client-urls":["https://199.19.213.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.238: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-04-11T17:48:35.462298Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.491394ms"} {"level":"info","ts":"2026-04-11T17:48:35.468871Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"8cf6035374726417","cluster-id":"e837e6e114b087e2"} {"level":"info","ts":"2026-04-11T17:48:35.469036Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8cf6035374726417 switched to configuration voters=()"} {"level":"info","ts":"2026-04-11T17:48:35.469077Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8cf6035374726417 became follower at term 0"} {"level":"info","ts":"2026-04-11T17:48:35.469102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8cf6035374726417 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-11T17:48:35.469121Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8cf6035374726417 became follower at term 1"} {"level":"info","ts":"2026-04-11T17:48:35.469194Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8cf6035374726417 switched to configuration voters=(10157309666551555095)"} {"level":"warn","ts":"2026-04-11T17:48:35.476525Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-11T17:48:35.478068Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-11T17:48:35.479404Z","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-04-11T17:48:35.482636Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"8cf6035374726417","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-11T17:48:35.482883Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8cf6035374726417","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-11T17:48:35.48303Z","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-04-11T17:48:35.48315Z","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-04-11T17:48:35.483164Z","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-04-11T17:48:35.484004Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8cf6035374726417 switched to configuration voters=(10157309666551555095)"} {"level":"info","ts":"2026-04-11T17:48:35.484152Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e837e6e114b087e2","local-member-id":"8cf6035374726417","added-peer-id":"8cf6035374726417","added-peer-peer-urls":["https://199.19.213.238:2380"]} {"level":"info","ts":"2026-04-11T17:48:35.493239Z","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-04-11T17:48:35.493474Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"8cf6035374726417","initial-advertise-peer-urls":["https://199.19.213.238:2380"],"listen-peer-urls":["https://199.19.213.238:2380"],"advertise-client-urls":["https://199.19.213.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-11T17:48:35.493505Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-11T17:48:35.49363Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.238:2380"} {"level":"info","ts":"2026-04-11T17:48:35.493645Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.238:2380"} {"level":"info","ts":"2026-04-11T17:48:35.670217Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8cf6035374726417 is starting a new election at term 1"} {"level":"info","ts":"2026-04-11T17:48:35.670341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8cf6035374726417 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-11T17:48:35.670364Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8cf6035374726417 received MsgPreVoteResp from 8cf6035374726417 at term 1"} {"level":"info","ts":"2026-04-11T17:48:35.670485Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8cf6035374726417 became candidate at term 2"} {"level":"info","ts":"2026-04-11T17:48:35.670502Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8cf6035374726417 received MsgVoteResp from 8cf6035374726417 at term 2"} {"level":"info","ts":"2026-04-11T17:48:35.670514Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8cf6035374726417 became leader at term 2"} {"level":"info","ts":"2026-04-11T17:48:35.670524Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8cf6035374726417 elected leader 8cf6035374726417 at term 2"} {"level":"info","ts":"2026-04-11T17:48:35.672194Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"8cf6035374726417","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.238:2379]}","request-path":"/0/members/8cf6035374726417/attributes","cluster-id":"e837e6e114b087e2","publish-timeout":"7s"} {"level":"info","ts":"2026-04-11T17:48:35.672223Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-11T17:48:35.672275Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-11T17:48:35.672451Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-11T17:48:35.672638Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-11T17:48:35.672701Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-11T17:48:35.67415Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e837e6e114b087e2","local-member-id":"8cf6035374726417","cluster-version":"3.5"} {"level":"info","ts":"2026-04-11T17:48:35.674279Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-11T17:48:35.674319Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-11T17:48:35.675711Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.238:2379"} {"level":"info","ts":"2026-04-11T17:48:35.677368Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-11T17:49:10.732888Z","caller":"traceutil/trace.go:171","msg":"trace[1843013021] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"153.833688ms","start":"2026-04-11T17:49:10.579024Z","end":"2026-04-11T17:49:10.732858Z","steps":["trace[1843013021] 'process raft request' (duration: 153.261698ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:49:12.707222Z","caller":"traceutil/trace.go:171","msg":"trace[175666341] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"121.455314ms","start":"2026-04-11T17:49:12.585738Z","end":"2026-04-11T17:49:12.707193Z","steps":["trace[175666341] 'process raft request' (duration: 79.103971ms)","trace[175666341] 'compare' (duration: 41.927335ms)"],"step_count":2} {"level":"info","ts":"2026-04-11T17:49:12.707226Z","caller":"traceutil/trace.go:171","msg":"trace[1125652355] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"121.290351ms","start":"2026-04-11T17:49:12.585899Z","end":"2026-04-11T17:49:12.707189Z","steps":["trace[1125652355] 'process raft request' (duration: 121.117248ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:49:12.70731Z","caller":"traceutil/trace.go:171","msg":"trace[1490523334] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"115.933211ms","start":"2026-04-11T17:49:12.591359Z","end":"2026-04-11T17:49:12.707292Z","steps":["trace[1490523334] 'process raft request' (duration: 115.766818ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:49:12.712536Z","caller":"traceutil/trace.go:171","msg":"trace[1316848007] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"120.514647ms","start":"2026-04-11T17:49:12.59201Z","end":"2026-04-11T17:49:12.712524Z","steps":["trace[1316848007] 'process raft request' (duration: 120.035878ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:49:12.712858Z","caller":"traceutil/trace.go:171","msg":"trace[1602026634] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"120.658069ms","start":"2026-04-11T17:49:12.59217Z","end":"2026-04-11T17:49:12.712828Z","steps":["trace[1602026634] 'process raft request' (duration: 120.027188ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:49:12.712932Z","caller":"traceutil/trace.go:171","msg":"trace[1049507812] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"118.807914ms","start":"2026-04-11T17:49:12.594106Z","end":"2026-04-11T17:49:12.712914Z","steps":["trace[1049507812] 'process raft request' (duration: 118.207243ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:49:12.712962Z","caller":"traceutil/trace.go:171","msg":"trace[1860049025] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"105.906532ms","start":"2026-04-11T17:49:12.607039Z","end":"2026-04-11T17:49:12.712945Z","steps":["trace[1860049025] 'process raft request' (duration: 105.403903ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:49:12.712915Z","caller":"traceutil/trace.go:171","msg":"trace[126946944] transaction","detail":"{read_only:false; number_of_response:1; response_revision:547; }","duration":"117.899747ms","start":"2026-04-11T17:49:12.594979Z","end":"2026-04-11T17:49:12.712879Z","steps":["trace[126946944] 'process raft request' (duration: 117.390888ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:49:19.326447Z","caller":"traceutil/trace.go:171","msg":"trace[188433472] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"160.667658ms","start":"2026-04-11T17:49:19.165752Z","end":"2026-04-11T17:49:19.32642Z","steps":["trace[188433472] 'process raft request' (duration: 159.909324ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:49:19.656364Z","caller":"traceutil/trace.go:171","msg":"trace[2143267389] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"306.584091ms","start":"2026-04-11T17:49:19.349756Z","end":"2026-04-11T17:49:19.65634Z","steps":["trace[2143267389] 'process raft request' (duration: 306.50942ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:49:19.656474Z","caller":"traceutil/trace.go:171","msg":"trace[480411266] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"313.344997ms","start":"2026-04-11T17:49:19.343053Z","end":"2026-04-11T17:49:19.656398Z","steps":["trace[480411266] 'process raft request' (duration: 236.819334ms)","trace[480411266] 'compare' (duration: 76.203657ms)"],"step_count":2} {"level":"warn","ts":"2026-04-11T17:49:19.657226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T17:49:19.349742Z","time spent":"306.714753ms","remote":"127.0.0.1:39716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-11T17:49:19.657291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T17:49:19.343032Z","time spent":"313.603112ms","remote":"127.0.0.1:39588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-11T17:49:19.669888Z","caller":"traceutil/trace.go:171","msg":"trace[299928516] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:653; }","duration":"225.461492ms","start":"2026-04-11T17:49:19.444388Z","end":"2026-04-11T17:49:19.669849Z","steps":["trace[299928516] 'read index received' (duration: 135.584589ms)","trace[299928516] 'applied index is now lower than readState.Index' (duration: 89.876183ms)"],"step_count":2} {"level":"info","ts":"2026-04-11T17:49:19.670066Z","caller":"traceutil/trace.go:171","msg":"trace[1974741485] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"286.360102ms","start":"2026-04-11T17:49:19.38364Z","end":"2026-04-11T17:49:19.67Z","steps":["trace[1974741485] 'process raft request' (duration: 286.085957ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:49:19.670063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.647485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-11T17:49:19.670783Z","caller":"traceutil/trace.go:171","msg":"trace[1735115850] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:633; }","duration":"226.42472ms","start":"2026-04-11T17:49:19.444333Z","end":"2026-04-11T17:49:19.670758Z","steps":["trace[1735115850] 'agreement among raft nodes before linearized reading' (duration: 225.649836ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:49:20.069442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.943356ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-11T17:49:20.069882Z","caller":"traceutil/trace.go:171","msg":"trace[640021294] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"353.679812ms","start":"2026-04-11T17:49:19.716169Z","end":"2026-04-11T17:49:20.069848Z","steps":["trace[640021294] 'process raft request' (duration: 45.060814ms)","trace[640021294] 'compare' (duration: 307.781223ms)"],"step_count":2} {"level":"warn","ts":"2026-04-11T17:49:20.070055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T17:49:19.716138Z","time spent":"353.816324ms","remote":"127.0.0.1:39798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-11T17:49:20.202758Z","caller":"traceutil/trace.go:171","msg":"trace[604061656] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"127.744992ms","start":"2026-04-11T17:49:20.074984Z","end":"2026-04-11T17:49:20.202729Z","steps":["trace[604061656] 'process raft request' (duration: 127.677131ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:49:20.202776Z","caller":"traceutil/trace.go:171","msg":"trace[615267306] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"130.499463ms","start":"2026-04-11T17:49:20.072222Z","end":"2026-04-11T17:49:20.202722Z","steps":["trace[615267306] 'process raft request' (duration: 125.896196ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:49:21.558642Z","caller":"traceutil/trace.go:171","msg":"trace[180991138] linearizableReadLoop","detail":"{readStateIndex:684; appliedIndex:681; }","duration":"106.28856ms","start":"2026-04-11T17:49:21.452315Z","end":"2026-04-11T17:49:21.558604Z","steps":["trace[180991138] 'read index received' (duration: 105.919263ms)","trace[180991138] 'applied index is now lower than readState.Index' (duration: 367.906µs)"],"step_count":2} {"level":"info","ts":"2026-04-11T17:49:21.558838Z","caller":"traceutil/trace.go:171","msg":"trace[937951998] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"118.962547ms","start":"2026-04-11T17:49:21.439858Z","end":"2026-04-11T17:49:21.55882Z","steps":["trace[937951998] 'process raft request' (duration: 118.622381ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:49:21.558879Z","caller":"traceutil/trace.go:171","msg":"trace[1981049846] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"120.400174ms","start":"2026-04-11T17:49:21.43843Z","end":"2026-04-11T17:49:21.55883Z","steps":["trace[1981049846] 'process raft request' (duration: 119.782002ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:49:21.55899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.625398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-11T17:49:21.559086Z","caller":"traceutil/trace.go:171","msg":"trace[335111070] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:661; }","duration":"120.761581ms","start":"2026-04-11T17:49:21.438302Z","end":"2026-04-11T17:49:21.559064Z","steps":["trace[335111070] 'agreement among raft nodes before linearized reading' (duration: 120.589638ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:49:21.559106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.73828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-11T17:49:21.559213Z","caller":"traceutil/trace.go:171","msg":"trace[33290517] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:0; response_revision:661; }","duration":"120.894563ms","start":"2026-04-11T17:49:21.438284Z","end":"2026-04-11T17:49:21.559178Z","steps":["trace[33290517] 'agreement among raft nodes before linearized reading' (duration: 120.74161ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:49:21.559195Z","caller":"traceutil/trace.go:171","msg":"trace[784935962] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"117.656663ms","start":"2026-04-11T17:49:21.4415Z","end":"2026-04-11T17:49:21.559156Z","steps":["trace[784935962] 'process raft request' (duration: 117.052042ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:49:21.559247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.698015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-11T17:49:21.559304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.989795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-11T17:49:21.559193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.815871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-11T17:49:21.559369Z","caller":"traceutil/trace.go:171","msg":"trace[96962522] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:661; }","duration":"116.902518ms","start":"2026-04-11T17:49:21.442445Z","end":"2026-04-11T17:49:21.559348Z","steps":["trace[96962522] 'agreement among raft nodes before linearized reading' (duration: 116.597793ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:49:21.559386Z","caller":"traceutil/trace.go:171","msg":"trace[1490859076] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:661; }","duration":"121.079436ms","start":"2026-04-11T17:49:21.438279Z","end":"2026-04-11T17:49:21.559358Z","steps":["trace[1490859076] 'agreement among raft nodes before linearized reading' (duration: 120.959234ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:49:21.559314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.193758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-11T17:49:21.559465Z","caller":"traceutil/trace.go:171","msg":"trace[49920180] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:0; response_revision:661; }","duration":"121.336011ms","start":"2026-04-11T17:49:21.438104Z","end":"2026-04-11T17:49:21.55944Z","steps":["trace[49920180] 'agreement among raft nodes before linearized reading' (duration: 121.151057ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:49:21.559622Z","caller":"traceutil/trace.go:171","msg":"trace[330284704] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:0; response_revision:661; }","duration":"121.072396ms","start":"2026-04-11T17:49:21.438318Z","end":"2026-04-11T17:49:21.55939Z","steps":["trace[330284704] 'agreement among raft nodes before linearized reading' (duration: 120.74129ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:50:53.93491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.139658ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-11T17:50:53.935102Z","caller":"traceutil/trace.go:171","msg":"trace[1971134454] transaction","detail":"{read_only:false; response_revision:1878; number_of_response:1; }","duration":"332.1131ms","start":"2026-04-11T17:50:53.602968Z","end":"2026-04-11T17:50:53.935081Z","steps":["trace[1971134454] 'process raft request' (duration: 183.675736ms)","trace[1971134454] 'compare' (duration: 147.768522ms)"],"step_count":2} {"level":"warn","ts":"2026-04-11T17:50:53.935165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T17:50:53.602929Z","time spent":"332.207102ms","remote":"127.0.0.1:39798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-11T17:50:53.938033Z","caller":"traceutil/trace.go:171","msg":"trace[1655689321] linearizableReadLoop","detail":"{readStateIndex:1951; appliedIndex:1950; }","duration":"129.034158ms","start":"2026-04-11T17:50:53.808976Z","end":"2026-04-11T17:50:53.93801Z","steps":["trace[1655689321] 'read index received' (duration: 128.800544ms)","trace[1655689321] 'applied index is now lower than readState.Index' (duration: 232.284µs)"],"step_count":2} {"level":"info","ts":"2026-04-11T17:50:53.938134Z","caller":"traceutil/trace.go:171","msg":"trace[1498087295] transaction","detail":"{read_only:false; response_revision:1879; number_of_response:1; }","duration":"228.315618ms","start":"2026-04-11T17:50:53.709775Z","end":"2026-04-11T17:50:53.938091Z","steps":["trace[1498087295] 'process raft request' (duration: 228.111313ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:50:53.938288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.306085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a756d87f-38d4-4fbc-b3e5-2e8e9772e0ed\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-04-11T17:50:53.938323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.70262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10668"} {"level":"info","ts":"2026-04-11T17:50:53.93835Z","caller":"traceutil/trace.go:171","msg":"trace[203690618] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a756d87f-38d4-4fbc-b3e5-2e8e9772e0ed; range_end:; response_count:1; response_revision:1879; }","duration":"129.414106ms","start":"2026-04-11T17:50:53.808917Z","end":"2026-04-11T17:50:53.938331Z","steps":["trace[203690618] 'agreement among raft nodes before linearized reading' (duration: 129.237083ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:50:53.938391Z","caller":"traceutil/trace.go:171","msg":"trace[497111687] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1879; }","duration":"122.824072ms","start":"2026-04-11T17:50:53.815551Z","end":"2026-04-11T17:50:53.938375Z","steps":["trace[497111687] 'agreement among raft nodes before linearized reading' (duration: 122.646939ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:50:54.349041Z","caller":"traceutil/trace.go:171","msg":"trace[1710389148] transaction","detail":"{read_only:false; response_revision:1881; number_of_response:1; }","duration":"342.557317ms","start":"2026-04-11T17:50:54.006439Z","end":"2026-04-11T17:50:54.348996Z","steps":["trace[1710389148] 'process raft request' (duration: 244.792727ms)","trace[1710389148] 'compare' (duration: 96.944235ms)"],"step_count":2} {"level":"info","ts":"2026-04-11T17:50:54.34906Z","caller":"traceutil/trace.go:171","msg":"trace[764989099] transaction","detail":"{read_only:false; response_revision:1882; number_of_response:1; }","duration":"342.529467ms","start":"2026-04-11T17:50:54.006477Z","end":"2026-04-11T17:50:54.349007Z","steps":["trace[764989099] 'process raft request' (duration: 342.437255ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:50:54.34928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T17:50:54.006464Z","time spent":"342.69173ms","remote":"127.0.0.1:39702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-11T17:50:54.34945Z","caller":"traceutil/trace.go:171","msg":"trace[1059817365] linearizableReadLoop","detail":"{readStateIndex:1958; appliedIndex:1952; }","duration":"278.668254ms","start":"2026-04-11T17:50:54.070764Z","end":"2026-04-11T17:50:54.349432Z","steps":["trace[1059817365] 'read index received' (duration: 180.554837ms)","trace[1059817365] 'applied index is now lower than readState.Index' (duration: 98.112207ms)"],"step_count":2} {"level":"warn","ts":"2026-04-11T17:50:54.34926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T17:50:54.00641Z","time spent":"342.72876ms","remote":"127.0.0.1:39798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-11T17:50:54.349525Z","caller":"traceutil/trace.go:171","msg":"trace[1657564719] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"342.820842ms","start":"2026-04-11T17:50:54.006693Z","end":"2026-04-11T17:50:54.349514Z","steps":["trace[1657564719] 'process raft request' (duration: 342.372474ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:50:54.349546Z","caller":"traceutil/trace.go:171","msg":"trace[495374047] transaction","detail":"{read_only:false; response_revision:1886; number_of_response:1; }","duration":"339.066602ms","start":"2026-04-11T17:50:54.01047Z","end":"2026-04-11T17:50:54.349536Z","steps":["trace[495374047] 'process raft request' (duration: 338.867758ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:50:54.349602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T17:50:54.006658Z","time spent":"342.896143ms","remote":"127.0.0.1:39702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":977,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-11T17:50:54.349646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T17:50:54.010456Z","time spent":"339.143143ms","remote":"127.0.0.1:39716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-11T17:50:54.349651Z","caller":"traceutil/trace.go:171","msg":"trace[775293995] transaction","detail":"{read_only:false; response_revision:1884; number_of_response:1; }","duration":"342.637059ms","start":"2026-04-11T17:50:54.006961Z","end":"2026-04-11T17:50:54.349599Z","steps":["trace[775293995] 'process raft request' (duration: 342.263822ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:50:54.349756Z","caller":"traceutil/trace.go:171","msg":"trace[976449497] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"342.243782ms","start":"2026-04-11T17:50:54.007457Z","end":"2026-04-11T17:50:54.349701Z","steps":["trace[976449497] 'process raft request' (duration: 341.827004ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:50:54.34989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T17:50:54.00695Z","time spent":"342.813672ms","remote":"127.0.0.1:39808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1529,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-11T17:50:54.349913Z","caller":"traceutil/trace.go:171","msg":"trace[282154273] transaction","detail":"{read_only:false; response_revision:1887; number_of_response:1; }","duration":"238.698844ms","start":"2026-04-11T17:50:54.111202Z","end":"2026-04-11T17:50:54.349901Z","steps":["trace[282154273] 'process raft request' (duration: 238.180903ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:50:54.350002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T17:50:54.007446Z","time spent":"342.422906ms","remote":"127.0.0.1:39808","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1471,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-11T17:50:54.350171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.402919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-11T17:50:54.350216Z","caller":"traceutil/trace.go:171","msg":"trace[371158617] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1887; }","duration":"279.45019ms","start":"2026-04-11T17:50:54.070756Z","end":"2026-04-11T17:50:54.350206Z","steps":["trace[371158617] 'agreement among raft nodes before linearized reading' (duration: 279.311118ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:50:54.350417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.143586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-11T17:50:54.350454Z","caller":"traceutil/trace.go:171","msg":"trace[1821595592] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1887; }","duration":"252.230618ms","start":"2026-04-11T17:50:54.098214Z","end":"2026-04-11T17:50:54.350445Z","steps":["trace[1821595592] 'agreement among raft nodes before linearized reading' (duration: 252.130416ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:51:45.034074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.411551ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-11T17:51:45.034217Z","caller":"traceutil/trace.go:171","msg":"trace[1846413340] linearizableReadLoop","detail":"{readStateIndex:2291; appliedIndex:2290; }","duration":"309.665799ms","start":"2026-04-11T17:51:44.724529Z","end":"2026-04-11T17:51:45.034195Z","steps":["trace[1846413340] 'read index received' (duration: 116.053386ms)","trace[1846413340] 'applied index is now lower than readState.Index' (duration: 193.610593ms)"],"step_count":2} {"level":"warn","ts":"2026-04-11T17:51:45.03449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.958665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-11T17:51:45.034637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.745469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-11T17:51:45.034668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.590295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-04-11T17:51:45.034707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.802249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-11T17:51:45.034789Z","caller":"traceutil/trace.go:171","msg":"trace[392275196] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2207; }","duration":"169.757428ms","start":"2026-04-11T17:51:44.864996Z","end":"2026-04-11T17:51:45.034753Z","steps":["trace[392275196] 'agreement among raft nodes before linearized reading' (duration: 169.461172ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:51:45.034843Z","caller":"traceutil/trace.go:171","msg":"trace[1533744286] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2207; }","duration":"290.053784ms","start":"2026-04-11T17:51:44.744764Z","end":"2026-04-11T17:51:45.034818Z","steps":["trace[1533744286] 'agreement among raft nodes before linearized reading' (duration: 289.665547ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:51:45.034751Z","caller":"traceutil/trace.go:171","msg":"trace[898325603] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2207; }","duration":"108.925712ms","start":"2026-04-11T17:51:44.925797Z","end":"2026-04-11T17:51:45.034723Z","steps":["trace[898325603] 'agreement among raft nodes before linearized reading' (duration: 108.636257ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:51:45.035205Z","caller":"traceutil/trace.go:171","msg":"trace[975789247] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2207; }","duration":"310.063957ms","start":"2026-04-11T17:51:44.72446Z","end":"2026-04-11T17:51:45.034524Z","steps":["trace[975789247] 'agreement among raft nodes before linearized reading' (duration: 309.836492ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:51:45.035277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T17:51:44.724431Z","time spent":"310.828252ms","remote":"127.0.0.1:39798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-11T17:51:45.420339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.7685ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-11T17:51:45.420618Z","caller":"traceutil/trace.go:171","msg":"trace[1827917649] transaction","detail":"{read_only:false; response_revision:2209; number_of_response:1; }","duration":"380.811028ms","start":"2026-04-11T17:51:45.039765Z","end":"2026-04-11T17:51:45.420576Z","steps":["trace[1827917649] 'process raft request' (duration: 233.680343ms)","trace[1827917649] 'compare' (duration: 146.545445ms)"],"step_count":2} {"level":"info","ts":"2026-04-11T17:51:45.420668Z","caller":"traceutil/trace.go:171","msg":"trace[737558196] linearizableReadLoop","detail":"{readStateIndex:2295; appliedIndex:2291; }","duration":"323.390646ms","start":"2026-04-11T17:51:45.097252Z","end":"2026-04-11T17:51:45.420642Z","steps":["trace[737558196] 'read index received' (duration: 22.845166ms)","trace[737558196] 'applied index is now lower than readState.Index' (duration: 300.54378ms)"],"step_count":2} {"level":"info","ts":"2026-04-11T17:51:45.420691Z","caller":"traceutil/trace.go:171","msg":"trace[372524034] transaction","detail":"{read_only:false; response_revision:2210; number_of_response:1; }","duration":"380.91548ms","start":"2026-04-11T17:51:45.039753Z","end":"2026-04-11T17:51:45.420668Z","steps":["trace[372524034] 'process raft request' (duration: 380.729797ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:51:45.420728Z","caller":"traceutil/trace.go:171","msg":"trace[2018319527] transaction","detail":"{read_only:false; response_revision:2211; number_of_response:1; }","duration":"380.795988ms","start":"2026-04-11T17:51:45.039882Z","end":"2026-04-11T17:51:45.420678Z","steps":["trace[2018319527] 'process raft request' (duration: 380.699637ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:51:45.420803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T17:51:45.039719Z","time spent":"381.031503ms","remote":"127.0.0.1:39798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-11T17:51:45.420832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T17:51:45.039719Z","time spent":"381.000052ms","remote":"127.0.0.1:39798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-11T17:51:45.42087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.61672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-11T17:51:45.420919Z","caller":"traceutil/trace.go:171","msg":"trace[1843291515] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2211; }","duration":"323.727292ms","start":"2026-04-11T17:51:45.09718Z","end":"2026-04-11T17:51:45.420908Z","steps":["trace[1843291515] 'agreement among raft nodes before linearized reading' (duration: 323.538509ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T17:51:45.420957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T17:51:45.097134Z","time spent":"323.815563ms","remote":"127.0.0.1:39798","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":"warn","ts":"2026-04-11T17:51:45.420954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T17:51:45.039772Z","time spent":"381.062543ms","remote":"127.0.0.1:39798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-11T17:51:45.4324Z","caller":"traceutil/trace.go:171","msg":"trace[1013651458] transaction","detail":"{read_only:false; response_revision:2212; number_of_response:1; }","duration":"255.482828ms","start":"2026-04-11T17:51:45.176887Z","end":"2026-04-11T17:51:45.43237Z","steps":["trace[1013651458] 'process raft request' (duration: 255.214133ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:51:45.43251Z","caller":"traceutil/trace.go:171","msg":"trace[2060913024] transaction","detail":"{read_only:false; response_revision:2213; number_of_response:1; }","duration":"232.288334ms","start":"2026-04-11T17:51:45.200205Z","end":"2026-04-11T17:51:45.432493Z","steps":["trace[2060913024] 'process raft request' (duration: 232.091041ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:51:45.437001Z","caller":"traceutil/trace.go:171","msg":"trace[1029078168] transaction","detail":"{read_only:false; response_revision:2214; number_of_response:1; }","duration":"121.347384ms","start":"2026-04-11T17:51:45.315624Z","end":"2026-04-11T17:51:45.436971Z","steps":["trace[1029078168] 'process raft request' (duration: 121.160451ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:56:51.373951Z","caller":"traceutil/trace.go:171","msg":"trace[1679996281] transaction","detail":"{read_only:false; response_revision:4841; number_of_response:1; }","duration":"108.266304ms","start":"2026-04-11T17:56:51.265645Z","end":"2026-04-11T17:56:51.373911Z","steps":["trace[1679996281] 'process raft request' (duration: 108.05195ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:57:13.661913Z","caller":"traceutil/trace.go:171","msg":"trace[2110550544] transaction","detail":"{read_only:false; response_revision:5362; number_of_response:1; }","duration":"132.313423ms","start":"2026-04-11T17:57:13.529574Z","end":"2026-04-11T17:57:13.661888Z","steps":["trace[2110550544] 'process raft request' (duration: 132.16031ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T17:58:36.047773Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3010} {"level":"info","ts":"2026-04-11T17:58:36.123352Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3010,"took":"74.450208ms","hash":912925771,"current-db-size-bytes":57958400,"current-db-size":"58 MB","current-db-size-in-use-bytes":31449088,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-11T17:58:36.123412Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":912925771,"revision":3010,"compact-revision":-1} {"level":"info","ts":"2026-04-11T18:03:06.849712Z","caller":"traceutil/trace.go:171","msg":"trace[1309019170] transaction","detail":"{read_only:false; response_revision:8126; number_of_response:1; }","duration":"194.261347ms","start":"2026-04-11T18:03:06.655422Z","end":"2026-04-11T18:03:06.849684Z","steps":["trace[1309019170] 'process raft request' (duration: 194.102334ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T18:03:06.954505Z","caller":"traceutil/trace.go:171","msg":"trace[955211644] transaction","detail":"{read_only:false; response_revision:8127; number_of_response:1; }","duration":"199.309891ms","start":"2026-04-11T18:03:06.755174Z","end":"2026-04-11T18:03:06.954484Z","steps":["trace[955211644] 'process raft request' (duration: 199.200769ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T18:03:18.351826Z","caller":"traceutil/trace.go:171","msg":"trace[1586002075] transaction","detail":"{read_only:false; response_revision:8188; number_of_response:1; }","duration":"360.167234ms","start":"2026-04-11T18:03:17.991596Z","end":"2026-04-11T18:03:18.351764Z","steps":["trace[1586002075] 'process raft request' (duration: 355.038159ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T18:03:18.351801Z","caller":"traceutil/trace.go:171","msg":"trace[2020752756] linearizableReadLoop","detail":"{readStateIndex:8478; appliedIndex:8477; }","duration":"342.619856ms","start":"2026-04-11T18:03:18.009108Z","end":"2026-04-11T18:03:18.351728Z","steps":["trace[2020752756] 'read index received' (duration: 75.759234ms)","trace[2020752756] 'applied index is now lower than readState.Index' (duration: 266.858802ms)"],"step_count":2} {"level":"warn","ts":"2026-04-11T18:03:18.351891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.751489ms","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-04-11T18:03:18.351998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T18:03:17.99158Z","time spent":"360.335467ms","remote":"127.0.0.1:39798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-11T18:03:18.351974Z","caller":"traceutil/trace.go:171","msg":"trace[1108841158] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/; range_end:/registry/ceph.rook.io/cephclusters0; response_count:0; response_revision:8188; }","duration":"342.881872ms","start":"2026-04-11T18:03:18.00907Z","end":"2026-04-11T18:03:18.351952Z","steps":["trace[1108841158] 'agreement among raft nodes before linearized reading' (duration: 342.699208ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T18:03:18.352085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T18:03:18.009052Z","time spent":"343.013574ms","remote":"127.0.0.1:51708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" count_only:true "} {"level":"warn","ts":"2026-04-11T18:03:18.352194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.052624ms","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-04-11T18:03:18.352271Z","caller":"traceutil/trace.go:171","msg":"trace[1107067299] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/; range_end:/registry/ceph.rook.io/cephclusters0; response_count:0; response_revision:8188; }","duration":"343.178308ms","start":"2026-04-11T18:03:18.009076Z","end":"2026-04-11T18:03:18.352254Z","steps":["trace[1107067299] 'agreement among raft nodes before linearized reading' (duration: 343.017074ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T18:03:18.352321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T18:03:18.009063Z","time spent":"343.247739ms","remote":"127.0.0.1:51708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":79,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" limit:10000 "} {"level":"warn","ts":"2026-04-11T18:03:18.356194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.517816ms","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-04-11T18:03:18.356257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.532945ms","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":"info","ts":"2026-04-11T18:03:18.356302Z","caller":"traceutil/trace.go:171","msg":"trace[1332178798] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:8189; }","duration":"109.587826ms","start":"2026-04-11T18:03:18.246698Z","end":"2026-04-11T18:03:18.356286Z","steps":["trace[1332178798] 'agreement among raft nodes before linearized reading' (duration: 109.529555ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T18:03:18.356281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.64546ms","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-04-11T18:03:18.356403Z","caller":"traceutil/trace.go:171","msg":"trace[504215024] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:8189; }","duration":"175.795742ms","start":"2026-04-11T18:03:18.180568Z","end":"2026-04-11T18:03:18.356364Z","steps":["trace[504215024] 'agreement among raft nodes before linearized reading' (duration: 175.540608ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T18:03:18.356515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.961366ms","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-04-11T18:03:18.356589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.319218ms","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":"warn","ts":"2026-04-11T18:03:18.356515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.83186ms","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-04-11T18:03:18.356677Z","caller":"traceutil/trace.go:171","msg":"trace[1940171892] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:8189; }","duration":"110.004674ms","start":"2026-04-11T18:03:18.24666Z","end":"2026-04-11T18:03:18.356665Z","steps":["trace[1940171892] 'agreement among raft nodes before linearized reading' (duration: 109.823421ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T18:03:18.356736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.503157ms","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-04-11T18:03:18.356782Z","caller":"traceutil/trace.go:171","msg":"trace[1673903553] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:8189; }","duration":"175.557668ms","start":"2026-04-11T18:03:18.181215Z","end":"2026-04-11T18:03:18.356772Z","steps":["trace[1673903553] 'agreement among raft nodes before linearized reading' (duration: 175.476336ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T18:03:18.356801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.828075ms","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":"info","ts":"2026-04-11T18:03:18.356834Z","caller":"traceutil/trace.go:171","msg":"trace[852406293] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:8189; }","duration":"331.879016ms","start":"2026-04-11T18:03:18.024946Z","end":"2026-04-11T18:03:18.356825Z","steps":["trace[852406293] 'agreement among raft nodes before linearized reading' (duration: 331.826245ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T18:03:18.356757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.174455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-11T18:03:18.356827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.974761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-11T18:03:18.356831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.953384ms","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-04-11T18:03:18.356903Z","caller":"traceutil/trace.go:171","msg":"trace[181611613] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:8189; }","duration":"194.102594ms","start":"2026-04-11T18:03:18.162777Z","end":"2026-04-11T18:03:18.35688Z","steps":["trace[181611613] 'agreement among raft nodes before linearized reading' (duration: 193.959601ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T18:03:18.356903Z","caller":"traceutil/trace.go:171","msg":"trace[1289154204] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:8189; }","duration":"194.45829ms","start":"2026-04-11T18:03:18.162425Z","end":"2026-04-11T18:03:18.356883Z","steps":["trace[1289154204] 'agreement among raft nodes before linearized reading' (duration: 194.131784ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T18:03:18.356915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.403452ms","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":"warn","ts":"2026-04-11T18:03:18.356923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.518362ms","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":"info","ts":"2026-04-11T18:03:18.356948Z","caller":"traceutil/trace.go:171","msg":"trace[1167166963] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:8189; }","duration":"312.451633ms","start":"2026-04-11T18:03:18.044488Z","end":"2026-04-11T18:03:18.35694Z","steps":["trace[1167166963] 'agreement among raft nodes before linearized reading' (duration: 312.403442ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T18:03:18.356914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.164566ms","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-04-11T18:03:18.356237Z","caller":"traceutil/trace.go:171","msg":"trace[1334020424] transaction","detail":"{read_only:false; response_revision:8189; number_of_response:1; }","duration":"198.522217ms","start":"2026-04-11T18:03:18.157702Z","end":"2026-04-11T18:03:18.356224Z","steps":["trace[1334020424] 'process raft request' (duration: 198.223721ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T18:03:18.356983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T18:03:18.044483Z","time spent":"312.491804ms","remote":"127.0.0.1:51738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true "} {"level":"info","ts":"2026-04-11T18:03:18.356983Z","caller":"traceutil/trace.go:171","msg":"trace[1195246628] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:8189; }","duration":"312.113547ms","start":"2026-04-11T18:03:18.044806Z","end":"2026-04-11T18:03:18.356919Z","steps":["trace[1195246628] 'agreement among raft nodes before linearized reading' (duration: 311.872712ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T18:03:18.357058Z","caller":"traceutil/trace.go:171","msg":"trace[1174865715] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:8189; }","duration":"156.316559ms","start":"2026-04-11T18:03:18.200676Z","end":"2026-04-11T18:03:18.356992Z","steps":["trace[1174865715] 'agreement among raft nodes before linearized reading' (duration: 156.086375ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T18:03:18.357127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.498107ms","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-04-11T18:03:18.35714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.633611ms","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-04-11T18:03:18.357148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.637637ms","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-04-11T18:03:18.357159Z","caller":"traceutil/trace.go:171","msg":"trace[50326654] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:8189; }","duration":"332.562668ms","start":"2026-04-11T18:03:18.024587Z","end":"2026-04-11T18:03:18.35715Z","steps":["trace[50326654] 'agreement among raft nodes before linearized reading' (duration: 332.511527ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T18:03:18.357165Z","caller":"traceutil/trace.go:171","msg":"trace[1828417130] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemmirrors/; range_end:/registry/ceph.rook.io/cephfilesystemmirrors0; response_count:0; response_revision:8189; }","duration":"248.664812ms","start":"2026-04-11T18:03:18.108492Z","end":"2026-04-11T18:03:18.357157Z","steps":["trace[1828417130] 'agreement among raft nodes before linearized reading' (duration: 248.631941ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T18:03:18.357154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T18:03:18.044798Z","time spent":"312.340771ms","remote":"127.0.0.1:51738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" limit:500 "} {"level":"info","ts":"2026-04-11T18:03:18.357184Z","caller":"traceutil/trace.go:171","msg":"trace[434865768] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:8189; }","duration":"207.708578ms","start":"2026-04-11T18:03:18.149459Z","end":"2026-04-11T18:03:18.357168Z","steps":["trace[434865768] 'agreement among raft nodes before linearized reading' (duration: 207.673887ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T18:03:18.3562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.020272ms","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":"warn","ts":"2026-04-11T18:03:18.357191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.434433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-11T18:03:18.357186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.151848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-11T18:03:18.357188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T18:03:18.024562Z","time spent":"332.618279ms","remote":"127.0.0.1:51722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" limit:10000 "} {"level":"warn","ts":"2026-04-11T18:03:18.356872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T18:03:18.024938Z","time spent":"331.923807ms","remote":"127.0.0.1:51722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" limit:500 "} {"level":"warn","ts":"2026-04-11T18:03:18.357378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.174164ms","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":"info","ts":"2026-04-11T18:03:18.357359Z","caller":"traceutil/trace.go:171","msg":"trace[1342626336] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:8189; }","duration":"296.392083ms","start":"2026-04-11T18:03:18.060932Z","end":"2026-04-11T18:03:18.357324Z","steps":["trace[1342626336] 'agreement among raft nodes before linearized reading' (duration: 295.947355ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T18:03:18.356553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.574392ms","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-04-11T18:03:18.357402Z","caller":"traceutil/trace.go:171","msg":"trace[1025062682] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:8189; }","duration":"225.195264ms","start":"2026-04-11T18:03:18.132199Z","end":"2026-04-11T18:03:18.357394Z","steps":["trace[1025062682] 'agreement among raft nodes before linearized reading' (duration: 225.164114ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T18:03:18.357392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.916438ms","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-04-11T18:03:18.356186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.519917ms","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-04-11T18:03:18.357403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.700397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-11T18:03:18.357414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.735673ms","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":"info","ts":"2026-04-11T18:03:18.357431Z","caller":"traceutil/trace.go:171","msg":"trace[1384259376] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:8189; }","duration":"278.5311ms","start":"2026-04-11T18:03:18.078887Z","end":"2026-04-11T18:03:18.357418Z","steps":["trace[1384259376] 'agreement among raft nodes before linearized reading' (duration: 277.484491ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T18:03:18.357446Z","caller":"traceutil/trace.go:171","msg":"trace[28970557] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemmirrors/; range_end:/registry/ceph.rook.io/cephfilesystemmirrors0; response_count:0; response_revision:8189; }","duration":"248.992549ms","start":"2026-04-11T18:03:18.108436Z","end":"2026-04-11T18:03:18.357429Z","steps":["trace[28970557] 'agreement among raft nodes before linearized reading' (duration: 248.899257ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T18:03:18.357451Z","caller":"traceutil/trace.go:171","msg":"trace[418439781] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:8189; }","duration":"297.761779ms","start":"2026-04-11T18:03:18.059678Z","end":"2026-04-11T18:03:18.35744Z","steps":["trace[418439781] 'agreement among raft nodes before linearized reading' (duration: 297.695478ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T18:03:18.356309Z","caller":"traceutil/trace.go:171","msg":"trace[1566246492] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:8189; }","duration":"206.615448ms","start":"2026-04-11T18:03:18.149653Z","end":"2026-04-11T18:03:18.356269Z","steps":["trace[1566246492] 'agreement among raft nodes before linearized reading' (duration: 206.404884ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T18:03:18.357445Z","caller":"traceutil/trace.go:171","msg":"trace[429356724] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:8189; }","duration":"109.80339ms","start":"2026-04-11T18:03:18.247632Z","end":"2026-04-11T18:03:18.357436Z","steps":["trace[429356724] 'agreement among raft nodes before linearized reading' (duration: 108.500446ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T18:03:18.35726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.745892ms","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":"warn","ts":"2026-04-11T18:03:18.357412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.107952ms","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":"info","ts":"2026-04-11T18:03:18.357454Z","caller":"traceutil/trace.go:171","msg":"trace[1784286142] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:8189; }","duration":"278.787204ms","start":"2026-04-11T18:03:18.078657Z","end":"2026-04-11T18:03:18.357445Z","steps":["trace[1784286142] 'agreement among raft nodes before linearized reading' (duration: 278.728673ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T18:03:18.357633Z","caller":"traceutil/trace.go:171","msg":"trace[1750838250] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:8189; }","duration":"278.340066ms","start":"2026-04-11T18:03:18.079279Z","end":"2026-04-11T18:03:18.357619Z","steps":["trace[1750838250] 'agreement among raft nodes before linearized reading' (duration: 278.061931ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T18:03:18.35659Z","caller":"traceutil/trace.go:171","msg":"trace[1645436173] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:8189; }","duration":"176.056867ms","start":"2026-04-11T18:03:18.180521Z","end":"2026-04-11T18:03:18.356578Z","steps":["trace[1645436173] 'agreement among raft nodes before linearized reading' (duration: 175.866834ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T18:03:18.356952Z","caller":"traceutil/trace.go:171","msg":"trace[1619326369] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:8189; }","duration":"156.591784ms","start":"2026-04-11T18:03:18.200352Z","end":"2026-04-11T18:03:18.356944Z","steps":["trace[1619326369] 'agreement among raft nodes before linearized reading' (duration: 156.517393ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T18:03:18.357083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.904878ms","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":"info","ts":"2026-04-11T18:03:18.357819Z","caller":"traceutil/trace.go:171","msg":"trace[32807436] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:8189; }","duration":"225.652874ms","start":"2026-04-11T18:03:18.132152Z","end":"2026-04-11T18:03:18.357805Z","steps":["trace[32807436] 'agreement among raft nodes before linearized reading' (duration: 224.910939ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T18:03:18.357058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.160446ms","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-04-11T18:03:18.357864Z","caller":"traceutil/trace.go:171","msg":"trace[1377939069] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:8189; }","duration":"156.984092ms","start":"2026-04-11T18:03:18.200865Z","end":"2026-04-11T18:03:18.357849Z","steps":["trace[1377939069] 'agreement among raft nodes before linearized reading' (duration: 156.149705ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T18:03:18.357106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.613881ms","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":"warn","ts":"2026-04-11T18:03:18.357118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.570475ms","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":"info","ts":"2026-04-11T18:03:18.357944Z","caller":"traceutil/trace.go:171","msg":"trace[1368320407] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:8189; }","duration":"208.407622ms","start":"2026-04-11T18:03:18.149523Z","end":"2026-04-11T18:03:18.357931Z","steps":["trace[1368320407] 'agreement among raft nodes before linearized reading' (duration: 207.577956ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T18:03:18.358001Z","caller":"traceutil/trace.go:171","msg":"trace[1558791109] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemmirrors/; range_end:/registry/ceph.rook.io/cephfilesystemmirrors0; response_count:0; response_revision:8189; }","duration":"249.451237ms","start":"2026-04-11T18:03:18.108473Z","end":"2026-04-11T18:03:18.357925Z","steps":["trace[1558791109] 'agreement among raft nodes before linearized reading' (duration: 248.607231ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T18:03:18.357272Z","caller":"traceutil/trace.go:171","msg":"trace[633085127] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:8189; }","duration":"135.080962ms","start":"2026-04-11T18:03:18.222141Z","end":"2026-04-11T18:03:18.357222Z","steps":["trace[633085127] 'agreement among raft nodes before linearized reading' (duration: 133.935521ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T18:03:18.3573Z","caller":"traceutil/trace.go:171","msg":"trace[1449798581] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:8189; }","duration":"297.597436ms","start":"2026-04-11T18:03:18.059675Z","end":"2026-04-11T18:03:18.357272Z","steps":["trace[1449798581] 'agreement among raft nodes before linearized reading' (duration: 297.372702ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T18:03:18.356555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.32435ms","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-04-11T18:03:18.357346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.126222ms","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":"info","ts":"2026-04-11T18:03:18.358175Z","caller":"traceutil/trace.go:171","msg":"trace[1189220474] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:8189; }","duration":"134.94221ms","start":"2026-04-11T18:03:18.223223Z","end":"2026-04-11T18:03:18.358165Z","steps":["trace[1189220474] 'agreement among raft nodes before linearized reading' (duration: 133.31236ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T18:03:18.358204Z","caller":"traceutil/trace.go:171","msg":"trace[1003610021] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:8189; }","duration":"225.99782ms","start":"2026-04-11T18:03:18.132194Z","end":"2026-04-11T18:03:18.358192Z","steps":["trace[1003610021] 'agreement among raft nodes before linearized reading' (duration: 225.133163ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T18:03:18.356628Z","caller":"traceutil/trace.go:171","msg":"trace[548305005] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:8189; }","duration":"134.352509ms","start":"2026-04-11T18:03:18.222262Z","end":"2026-04-11T18:03:18.356614Z","steps":["trace[548305005] 'agreement among raft nodes before linearized reading' (duration: 134.307918ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T18:03:18.356997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.510424ms","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":"info","ts":"2026-04-11T18:03:18.358275Z","caller":"traceutil/trace.go:171","msg":"trace[643340018] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:8189; }","duration":"313.802538ms","start":"2026-04-11T18:03:18.044467Z","end":"2026-04-11T18:03:18.358269Z","steps":["trace[643340018] 'agreement among raft nodes before linearized reading' (duration: 312.449673ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T18:03:18.358297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T18:03:18.044423Z","time spent":"313.86496ms","remote":"127.0.0.1:51738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" limit:10000 "} {"level":"info","ts":"2026-04-11T18:03:18.357587Z","caller":"traceutil/trace.go:171","msg":"trace[1581195161] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:8189; }","duration":"333.072428ms","start":"2026-04-11T18:03:18.024503Z","end":"2026-04-11T18:03:18.357575Z","steps":["trace[1581195161] 'agreement among raft nodes before linearized reading' (duration: 332.726241ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T18:03:18.358361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T18:03:18.024483Z","time spent":"333.865723ms","remote":"127.0.0.1:51722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" count_only:true "} {"level":"warn","ts":"2026-04-11T18:03:18.357786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.822194ms","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-04-11T18:03:18.358795Z","caller":"traceutil/trace.go:171","msg":"trace[734834658] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/; range_end:/registry/ceph.rook.io/cephclusters0; response_count:0; response_revision:8189; }","duration":"348.713012ms","start":"2026-04-11T18:03:18.009903Z","end":"2026-04-11T18:03:18.358616Z","steps":["trace[734834658] 'agreement among raft nodes before linearized reading' (duration: 346.134143ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T18:03:18.358841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-11T18:03:18.009884Z","time spent":"348.943905ms","remote":"127.0.0.1:51708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":79,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" limit:500 "} {"level":"warn","ts":"2026-04-11T18:03:18.356674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.224066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-11T18:03:18.359634Z","caller":"traceutil/trace.go:171","msg":"trace[1999023671] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:8189; }","duration":"197.218892ms","start":"2026-04-11T18:03:18.162394Z","end":"2026-04-11T18:03:18.359613Z","steps":["trace[1999023671] 'agreement among raft nodes before linearized reading' (duration: 194.210516ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T18:03:19.34901Z","caller":"traceutil/trace.go:171","msg":"trace[1728131343] transaction","detail":"{read_only:false; response_revision:8192; number_of_response:1; }","duration":"256.219393ms","start":"2026-04-11T18:03:19.092769Z","end":"2026-04-11T18:03:19.348989Z","steps":["trace[1728131343] 'process raft request' (duration: 256.018609ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T18:03:20.253519Z","caller":"traceutil/trace.go:171","msg":"trace[1178157611] transaction","detail":"{read_only:false; response_revision:8198; number_of_response:1; }","duration":"163.687365ms","start":"2026-04-11T18:03:20.089799Z","end":"2026-04-11T18:03:20.253487Z","steps":["trace[1178157611] 'process raft request' (duration: 90.827085ms)","trace[1178157611] 'compare' (duration: 72.711957ms)"],"step_count":2} {"level":"info","ts":"2026-04-11T18:03:36.055917Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6118} {"level":"info","ts":"2026-04-11T18:03:36.160228Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6118,"took":"102.88919ms","hash":1813865259,"current-db-size-bytes":57958400,"current-db-size":"58 MB","current-db-size-in-use-bytes":23113728,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-11T18:03:36.160297Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1813865259,"revision":6118,"compact-revision":3010} {"level":"info","ts":"2026-04-11T18:03:51.177343Z","caller":"traceutil/trace.go:171","msg":"trace[164986877] transaction","detail":"{read_only:false; response_revision:8418; number_of_response:1; }","duration":"194.563132ms","start":"2026-04-11T18:03:50.982743Z","end":"2026-04-11T18:03:51.177306Z","steps":["trace[164986877] 'process raft request' (duration: 194.217906ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T18:04:00.684404Z","caller":"traceutil/trace.go:171","msg":"trace[619996202] transaction","detail":"{read_only:false; response_revision:8514; number_of_response:1; }","duration":"122.431146ms","start":"2026-04-11T18:04:00.561933Z","end":"2026-04-11T18:04:00.684364Z","steps":["trace[619996202] 'process raft request' (duration: 70.606938ms)","trace[619996202] 'compare' (duration: 51.679995ms)"],"step_count":2} {"level":"info","ts":"2026-04-11T18:04:00.770801Z","caller":"traceutil/trace.go:171","msg":"trace[258193609] transaction","detail":"{read_only:false; response_revision:8515; number_of_response:1; }","duration":"128.513618ms","start":"2026-04-11T18:04:00.642261Z","end":"2026-04-11T18:04:00.770775Z","steps":["trace[258193609] 'process raft request' (duration: 128.316005ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T18:04:01.498404Z","caller":"traceutil/trace.go:171","msg":"trace[1048022301] transaction","detail":"{read_only:false; response_revision:8519; number_of_response:1; }","duration":"180.555661ms","start":"2026-04-11T18:04:01.315725Z","end":"2026-04-11T18:04:01.496281Z","steps":["trace[1048022301] 'process raft request' (duration: 180.260206ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T18:04:01.803041Z","caller":"traceutil/trace.go:171","msg":"trace[874461451] linearizableReadLoop","detail":"{readStateIndex:8828; appliedIndex:8827; }","duration":"135.936837ms","start":"2026-04-11T18:04:01.667075Z","end":"2026-04-11T18:04:01.803012Z","steps":["trace[874461451] 'read index received' (duration: 135.759304ms)","trace[874461451] 'applied index is now lower than readState.Index' (duration: 175.823µs)"],"step_count":2} {"level":"info","ts":"2026-04-11T18:04:01.803381Z","caller":"traceutil/trace.go:171","msg":"trace[1088062074] transaction","detail":"{read_only:false; response_revision:8524; number_of_response:1; }","duration":"138.114058ms","start":"2026-04-11T18:04:01.665253Z","end":"2026-04-11T18:04:01.803367Z","steps":["trace[1088062074] 'process raft request' (duration: 137.603879ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T18:04:01.803561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.151654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-hflt6\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-11T18:04:01.803636Z","caller":"traceutil/trace.go:171","msg":"trace[619205791] range","detail":"{range_begin:/registry/pods/openstack/keepalived-hflt6; range_end:; response_count:1; response_revision:8524; }","duration":"134.258897ms","start":"2026-04-11T18:04:01.669361Z","end":"2026-04-11T18:04:01.803619Z","steps":["trace[619205791] 'agreement among raft nodes before linearized reading' (duration: 134.054693ms)"],"step_count":1} {"level":"warn","ts":"2026-04-11T18:04:01.803654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.545178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-04-11T18:04:01.803752Z","caller":"traceutil/trace.go:171","msg":"trace[1926107638] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:8524; }","duration":"136.710882ms","start":"2026-04-11T18:04:01.667017Z","end":"2026-04-11T18:04:01.803728Z","steps":["trace[1926107638] 'agreement among raft nodes before linearized reading' (duration: 136.449807ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T18:04:58.272443Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024c5.wal"} {"level":"info","ts":"2026-04-11T18:05:16.144874Z","caller":"traceutil/trace.go:171","msg":"trace[1609419632] transaction","detail":"{read_only:false; response_revision:9256; number_of_response:1; }","duration":"126.562252ms","start":"2026-04-11T18:05:16.018283Z","end":"2026-04-11T18:05:16.144845Z","steps":["trace[1609419632] 'process raft request' (duration: 126.389859ms)"],"step_count":1} {"level":"info","ts":"2026-04-11T18:05:16.321568Z","caller":"traceutil/trace.go:171","msg":"trace[63783580] transaction","detail":"{read_only:false; response_revision:9257; number_of_response:1; }","duration":"136.282414ms","start":"2026-04-11T18:05:16.185244Z","end":"2026-04-11T18:05:16.321527Z","steps":["trace[63783580] 'process raft request' (duration: 70.132299ms)","trace[63783580] 'compare' (duration: 65.87339ms)"],"step_count":2} {"level":"info","ts":"2026-04-11T18:06:12.270203Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"8cf6035374726417","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-11T18:06:12.276562Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-11T18:06:12.276663Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-11T18:08:36.063416Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8288} {"level":"info","ts":"2026-04-11T18:08:36.137926Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8288,"took":"72.481342ms","hash":1513946039,"current-db-size-bytes":57958400,"current-db-size":"58 MB","current-db-size-in-use-bytes":24895488,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-11T18:08:36.137984Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1513946039,"revision":8288,"compact-revision":6118} {"level":"info","ts":"2026-04-11T18:13:36.069431Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10677} {"level":"info","ts":"2026-04-11T18:13:36.146742Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10677,"took":"75.675484ms","hash":3600032814,"current-db-size-bytes":57958400,"current-db-size":"58 MB","current-db-size-in-use-bytes":20471808,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-11T18:13:36.146798Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3600032814,"revision":10677,"compact-revision":8288}