{"level":"warn","ts":"2026-03-15T02:01:13.182172Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-15T02:01:13.182268Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.110:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.110:2380","--initial-cluster=instance=https://162.253.55.110:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.110:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.110: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-03-15T02:01:13.182332Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-15T02:01:13.182341Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.110:2380"]} {"level":"info","ts":"2026-03-15T02:01:13.182359Z","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-03-15T02:01:13.183092Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.110:2379"]} {"level":"info","ts":"2026-03-15T02:01:13.183164Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.110:2380"],"listen-peer-urls":["https://162.253.55.110:2380"],"advertise-client-urls":["https://162.253.55.110:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.110:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.110: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-03-15T02:01:13.188745Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.376445ms"} {"level":"info","ts":"2026-03-15T02:01:13.196915Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f52f30d5714009d5","cluster-id":"650981a7a383c714"} {"level":"info","ts":"2026-03-15T02:01:13.196984Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 switched to configuration voters=()"} {"level":"info","ts":"2026-03-15T02:01:13.197005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became follower at term 0"} {"level":"info","ts":"2026-03-15T02:01:13.197017Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f52f30d5714009d5 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-15T02:01:13.197033Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became follower at term 1"} {"level":"info","ts":"2026-03-15T02:01:13.19707Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 switched to configuration voters=(17667393556483934677)"} {"level":"warn","ts":"2026-03-15T02:01:13.206063Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-15T02:01:13.212001Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-15T02:01:13.214377Z","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-03-15T02:01:13.216602Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f52f30d5714009d5","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-15T02:01:13.216702Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f52f30d5714009d5","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-15T02:01:13.216891Z","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-03-15T02:01:13.217036Z","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-03-15T02:01:13.217053Z","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-03-15T02:01:13.218949Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 switched to configuration voters=(17667393556483934677)"} {"level":"info","ts":"2026-03-15T02:01:13.219298Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"650981a7a383c714","local-member-id":"f52f30d5714009d5","added-peer-id":"f52f30d5714009d5","added-peer-peer-urls":["https://162.253.55.110:2380"]} {"level":"info","ts":"2026-03-15T02:01:13.220578Z","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-03-15T02:01:13.22079Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f52f30d5714009d5","initial-advertise-peer-urls":["https://162.253.55.110:2380"],"listen-peer-urls":["https://162.253.55.110:2380"],"advertise-client-urls":["https://162.253.55.110:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.110:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-15T02:01:13.220788Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.110:2380"} {"level":"info","ts":"2026-03-15T02:01:13.220853Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.110:2380"} {"level":"info","ts":"2026-03-15T02:01:13.221433Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-15T02:01:13.397856Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 is starting a new election at term 1"} {"level":"info","ts":"2026-03-15T02:01:13.397895Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became pre-candidate at term 1"} {"level":"info","ts":"2026-03-15T02:01:13.397921Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 received MsgPreVoteResp from f52f30d5714009d5 at term 1"} {"level":"info","ts":"2026-03-15T02:01:13.397935Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became candidate at term 2"} {"level":"info","ts":"2026-03-15T02:01:13.397943Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 received MsgVoteResp from f52f30d5714009d5 at term 2"} {"level":"info","ts":"2026-03-15T02:01:13.397954Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became leader at term 2"} {"level":"info","ts":"2026-03-15T02:01:13.397964Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f52f30d5714009d5 elected leader f52f30d5714009d5 at term 2"} {"level":"info","ts":"2026-03-15T02:01:13.398783Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-15T02:01:13.399373Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f52f30d5714009d5","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.110:2379]}","request-path":"/0/members/f52f30d5714009d5/attributes","cluster-id":"650981a7a383c714","publish-timeout":"7s"} {"level":"info","ts":"2026-03-15T02:01:13.399522Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-15T02:01:13.3996Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-15T02:01:13.400083Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"650981a7a383c714","local-member-id":"f52f30d5714009d5","cluster-version":"3.5"} {"level":"info","ts":"2026-03-15T02:01:13.400201Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-15T02:01:13.400231Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-15T02:01:13.403177Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-15T02:01:13.403232Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.110:2379"} {"level":"info","ts":"2026-03-15T02:01:13.403373Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-15T02:01:13.403397Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"warn","ts":"2026-03-15T02:01:39.452311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.416455ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-15T02:01:39.452456Z","caller":"traceutil/trace.go:171","msg":"trace[838326205] linearizableReadLoop","detail":"{readStateIndex:443; appliedIndex:442; }","duration":"136.6194ms","start":"2026-03-15T02:01:39.315802Z","end":"2026-03-15T02:01:39.452421Z","steps":["trace[838326205] 'read index received' (duration: 37.471µs)","trace[838326205] 'applied index is now lower than readState.Index' (duration: 136.580299ms)"],"step_count":2} {"level":"info","ts":"2026-03-15T02:01:39.452503Z","caller":"traceutil/trace.go:171","msg":"trace[615339588] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"345.110378ms","start":"2026-03-15T02:01:39.107344Z","end":"2026-03-15T02:01:39.452454Z","steps":["trace[615339588] 'process raft request' (duration: 164.032815ms)","trace[615339588] 'compare' (duration: 176.964072ms)"],"step_count":2} {"level":"warn","ts":"2026-03-15T02:01:39.452578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.240271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-03-15T02:01:39.4526Z","caller":"traceutil/trace.go:171","msg":"trace[1925979981] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:425; }","duration":"107.300202ms","start":"2026-03-15T02:01:39.345293Z","end":"2026-03-15T02:01:39.452593Z","steps":["trace[1925979981] 'agreement among raft nodes before linearized reading' (duration: 107.237ms)"],"step_count":1} {"level":"warn","ts":"2026-03-15T02:01:39.452607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.798474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12669"} {"level":"info","ts":"2026-03-15T02:01:39.452687Z","caller":"traceutil/trace.go:171","msg":"trace[583483963] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:425; }","duration":"136.878856ms","start":"2026-03-15T02:01:39.31579Z","end":"2026-03-15T02:01:39.452669Z","steps":["trace[583483963] 'agreement among raft nodes before linearized reading' (duration: 136.736002ms)"],"step_count":1} {"level":"warn","ts":"2026-03-15T02:01:39.452673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-15T02:01:39.107333Z","time spent":"345.255763ms","remote":"127.0.0.1:37882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-15T02:01:47.80539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.293979ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-15T02:01:47.805619Z","caller":"traceutil/trace.go:171","msg":"trace[1995278134] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"252.575117ms","start":"2026-03-15T02:01:47.55299Z","end":"2026-03-15T02:01:47.805566Z","steps":["trace[1995278134] 'process raft request' (duration: 110.009649ms)","trace[1995278134] 'compare' (duration: 142.122755ms)"],"step_count":2} {"level":"info","ts":"2026-03-15T02:01:48.3695Z","caller":"traceutil/trace.go:171","msg":"trace[1766650494] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"104.681961ms","start":"2026-03-15T02:01:48.264792Z","end":"2026-03-15T02:01:48.369474Z","steps":["trace[1766650494] 'process raft request' (duration: 104.525957ms)"],"step_count":1} {"level":"info","ts":"2026-03-15T02:01:49.930284Z","caller":"traceutil/trace.go:171","msg":"trace[151259274] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"109.099664ms","start":"2026-03-15T02:01:49.821155Z","end":"2026-03-15T02:01:49.930255Z","steps":["trace[151259274] 'process raft request' (duration: 79.61025ms)","trace[151259274] 'compare' (duration: 28.796605ms)"],"step_count":2} {"level":"warn","ts":"2026-03-15T02:02:58.484556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.04434ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-15T02:02:58.484787Z","caller":"traceutil/trace.go:171","msg":"trace[1654049056] transaction","detail":"{read_only:false; response_revision:1557; number_of_response:1; }","duration":"315.049042ms","start":"2026-03-15T02:02:58.169701Z","end":"2026-03-15T02:02:58.48475Z","steps":["trace[1654049056] 'process raft request' (duration: 76.724665ms)","trace[1654049056] 'compare' (duration: 237.932486ms)"],"step_count":2} {"level":"warn","ts":"2026-03-15T02:02:58.484973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-15T02:02:58.169685Z","time spent":"315.186506ms","remote":"127.0.0.1:37882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-15T02:02:58.824883Z","caller":"traceutil/trace.go:171","msg":"trace[1344857855] transaction","detail":"{read_only:false; response_revision:1558; number_of_response:1; }","duration":"134.056055ms","start":"2026-03-15T02:02:58.690805Z","end":"2026-03-15T02:02:58.824861Z","steps":["trace[1344857855] 'process raft request' (duration: 133.8797ms)"],"step_count":1} {"level":"info","ts":"2026-03-15T02:02:58.884165Z","caller":"traceutil/trace.go:171","msg":"trace[1803558335] transaction","detail":"{read_only:false; response_revision:1559; number_of_response:1; }","duration":"159.746192ms","start":"2026-03-15T02:02:58.724386Z","end":"2026-03-15T02:02:58.884132Z","steps":["trace[1803558335] 'process raft request' (duration: 159.629158ms)"],"step_count":1} {"level":"info","ts":"2026-03-15T02:03:43.130345Z","caller":"traceutil/trace.go:171","msg":"trace[1212787798] transaction","detail":"{read_only:false; response_revision:1826; number_of_response:1; }","duration":"108.316576ms","start":"2026-03-15T02:03:43.022Z","end":"2026-03-15T02:03:43.130316Z","steps":["trace[1212787798] 'process raft request' (duration: 108.025338ms)"],"step_count":1} {"level":"info","ts":"2026-03-15T02:03:48.460144Z","caller":"traceutil/trace.go:171","msg":"trace[870006884] transaction","detail":"{read_only:false; response_revision:1853; number_of_response:1; }","duration":"116.316185ms","start":"2026-03-15T02:03:48.34378Z","end":"2026-03-15T02:03:48.460096Z","steps":["trace[870006884] 'process raft request' (duration: 88.789707ms)","trace[870006884] 'compare' (duration: 27.21126ms)"],"step_count":2} {"level":"warn","ts":"2026-03-15T02:03:49.210536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.439654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-15T02:03:49.210585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.274463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-15T02:03:49.210666Z","caller":"traceutil/trace.go:171","msg":"trace[1018696144] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:1855; }","duration":"170.433267ms","start":"2026-03-15T02:03:49.040207Z","end":"2026-03-15T02:03:49.210641Z","steps":["trace[1018696144] 'count revisions from in-memory index tree' (duration: 170.120598ms)"],"step_count":1} {"level":"info","ts":"2026-03-15T02:03:49.21067Z","caller":"traceutil/trace.go:171","msg":"trace[1553578032] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1855; }","duration":"134.588278ms","start":"2026-03-15T02:03:49.07605Z","end":"2026-03-15T02:03:49.210638Z","steps":["trace[1553578032] 'range keys from in-memory index tree' (duration: 134.351823ms)"],"step_count":1} {"level":"info","ts":"2026-03-15T02:03:49.29481Z","caller":"traceutil/trace.go:171","msg":"trace[1576933860] linearizableReadLoop","detail":"{readStateIndex:1934; appliedIndex:1933; }","duration":"128.551883ms","start":"2026-03-15T02:03:49.166233Z","end":"2026-03-15T02:03:49.294785Z","steps":["trace[1576933860] 'read index received' (duration: 128.328267ms)","trace[1576933860] 'applied index is now lower than readState.Index' (duration: 222.846µs)"],"step_count":2} {"level":"info","ts":"2026-03-15T02:03:49.294923Z","caller":"traceutil/trace.go:171","msg":"trace[1817113738] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"139.902136ms","start":"2026-03-15T02:03:49.154983Z","end":"2026-03-15T02:03:49.294885Z","steps":["trace[1817113738] 'process raft request' (duration: 139.641308ms)"],"step_count":1} {"level":"warn","ts":"2026-03-15T02:03:49.295241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.789679ms","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-03-15T02:03:49.295318Z","caller":"traceutil/trace.go:171","msg":"trace[1768491810] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1856; }","duration":"129.133458ms","start":"2026-03-15T02:03:49.166165Z","end":"2026-03-15T02:03:49.295299Z","steps":["trace[1768491810] 'agreement among raft nodes before linearized reading' (duration: 128.737647ms)"],"step_count":1} {"level":"info","ts":"2026-03-15T02:04:48.776468Z","caller":"traceutil/trace.go:171","msg":"trace[1802960951] transaction","detail":"{read_only:false; response_revision:2316; number_of_response:1; }","duration":"159.120521ms","start":"2026-03-15T02:04:48.617321Z","end":"2026-03-15T02:04:48.776442Z","steps":["trace[1802960951] 'process raft request' (duration: 158.964706ms)"],"step_count":1} {"level":"info","ts":"2026-03-15T02:04:48.798967Z","caller":"traceutil/trace.go:171","msg":"trace[2060632660] transaction","detail":"{read_only:false; response_revision:2317; number_of_response:1; }","duration":"180.868877ms","start":"2026-03-15T02:04:48.618082Z","end":"2026-03-15T02:04:48.798951Z","steps":["trace[2060632660] 'process raft request' (duration: 178.971005ms)"],"step_count":1} {"level":"info","ts":"2026-03-15T02:05:23.853704Z","caller":"traceutil/trace.go:171","msg":"trace[1198043182] linearizableReadLoop","detail":"{readStateIndex:2617; appliedIndex:2616; }","duration":"161.09155ms","start":"2026-03-15T02:05:23.692588Z","end":"2026-03-15T02:05:23.853679Z","steps":["trace[1198043182] 'read index received' (duration: 18.701665ms)","trace[1198043182] 'applied index is now lower than readState.Index' (duration: 142.388905ms)"],"step_count":2} {"level":"info","ts":"2026-03-15T02:05:23.853823Z","caller":"traceutil/trace.go:171","msg":"trace[431440482] transaction","detail":"{read_only:false; response_revision:2511; number_of_response:1; }","duration":"190.035205ms","start":"2026-03-15T02:05:23.663775Z","end":"2026-03-15T02:05:23.853811Z","steps":["trace[431440482] 'process raft request' (duration: 189.759608ms)"],"step_count":1} {"level":"warn","ts":"2026-03-15T02:05:23.853906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.293146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-15T02:05:23.854Z","caller":"traceutil/trace.go:171","msg":"trace[1209211155] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:2511; }","duration":"161.43752ms","start":"2026-03-15T02:05:23.69254Z","end":"2026-03-15T02:05:23.853977Z","steps":["trace[1209211155] 'agreement among raft nodes before linearized reading' (duration: 161.286245ms)"],"step_count":1} {"level":"info","ts":"2026-03-15T02:05:23.918602Z","caller":"traceutil/trace.go:171","msg":"trace[1041504518] transaction","detail":"{read_only:false; response_revision:2512; number_of_response:1; }","duration":"114.738725ms","start":"2026-03-15T02:05:23.803821Z","end":"2026-03-15T02:05:23.91856Z","steps":["trace[1041504518] 'process raft request' (duration: 114.579661ms)"],"step_count":1} {"level":"warn","ts":"2026-03-15T02:05:23.918682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.091241ms","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-03-15T02:05:23.918748Z","caller":"traceutil/trace.go:171","msg":"trace[1168398621] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2512; }","duration":"205.198714ms","start":"2026-03-15T02:05:23.713534Z","end":"2026-03-15T02:05:23.918733Z","steps":["trace[1168398621] 'agreement among raft nodes before linearized reading' (duration: 204.981318ms)"],"step_count":1} {"level":"warn","ts":"2026-03-15T02:05:23.919017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.796293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-03-15T02:05:23.919085Z","caller":"traceutil/trace.go:171","msg":"trace[1804559721] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:2512; }","duration":"160.896416ms","start":"2026-03-15T02:05:23.75817Z","end":"2026-03-15T02:05:23.919066Z","steps":["trace[1804559721] 'agreement among raft nodes before linearized reading' (duration: 160.640629ms)"],"step_count":1} {"level":"info","ts":"2026-03-15T02:07:49.073796Z","caller":"traceutil/trace.go:171","msg":"trace[870454205] transaction","detail":"{read_only:false; response_revision:3407; number_of_response:1; }","duration":"132.488452ms","start":"2026-03-15T02:07:48.941273Z","end":"2026-03-15T02:07:49.073762Z","steps":["trace[870454205] 'process raft request' (duration: 132.298017ms)"],"step_count":1} {"level":"info","ts":"2026-03-15T02:09:20.358227Z","caller":"traceutil/trace.go:171","msg":"trace[1783308836] transaction","detail":"{read_only:false; response_revision:4593; number_of_response:1; }","duration":"108.121203ms","start":"2026-03-15T02:09:20.250076Z","end":"2026-03-15T02:09:20.358197Z","steps":["trace[1783308836] 'process raft request' (duration: 107.936887ms)"],"step_count":1} {"level":"info","ts":"2026-03-15T02:09:20.516967Z","caller":"traceutil/trace.go:171","msg":"trace[654370983] linearizableReadLoop","detail":"{readStateIndex:4784; appliedIndex:4782; }","duration":"214.026274ms","start":"2026-03-15T02:09:20.302908Z","end":"2026-03-15T02:09:20.516934Z","steps":["trace[654370983] 'read index received' (duration: 55.261365ms)","trace[654370983] 'applied index is now lower than readState.Index' (duration: 158.763569ms)"],"step_count":2} {"level":"info","ts":"2026-03-15T02:09:20.517156Z","caller":"traceutil/trace.go:171","msg":"trace[1665346361] transaction","detail":"{read_only:false; response_revision:4594; number_of_response:1; }","duration":"265.969328ms","start":"2026-03-15T02:09:20.251162Z","end":"2026-03-15T02:09:20.517131Z","steps":["trace[1665346361] 'process raft request' (duration: 252.817528ms)","trace[1665346361] 'compare' (duration: 12.80717ms)"],"step_count":2} {"level":"warn","ts":"2026-03-15T02:09:20.517416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.824202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-60d80bda-fe04-412b-a162-4f06c6d44481\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-03-15T02:09:20.517559Z","caller":"traceutil/trace.go:171","msg":"trace[1593448476] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-60d80bda-fe04-412b-a162-4f06c6d44481; range_end:; response_count:1; response_revision:4594; }","duration":"204.999316ms","start":"2026-03-15T02:09:20.312531Z","end":"2026-03-15T02:09:20.51753Z","steps":["trace[1593448476] 'agreement among raft nodes before linearized reading' (duration: 204.635017ms)"],"step_count":1} {"level":"warn","ts":"2026-03-15T02:09:20.517876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.93935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:1 size:894"} {"level":"info","ts":"2026-03-15T02:09:20.517956Z","caller":"traceutil/trace.go:171","msg":"trace[983689856] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:1; response_revision:4594; }","duration":"215.104154ms","start":"2026-03-15T02:09:20.302833Z","end":"2026-03-15T02:09:20.517937Z","steps":["trace[983689856] 'agreement among raft nodes before linearized reading' (duration: 214.917009ms)"],"step_count":1} {"level":"warn","ts":"2026-03-15T02:09:20.518405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.655256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:777469"} {"level":"info","ts":"2026-03-15T02:09:20.518459Z","caller":"traceutil/trace.go:171","msg":"trace[634725464] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:4594; }","duration":"120.764299ms","start":"2026-03-15T02:09:20.397681Z","end":"2026-03-15T02:09:20.518445Z","steps":["trace[634725464] 'agreement among raft nodes before linearized reading' (duration: 120.178793ms)"],"step_count":1} {"level":"info","ts":"2026-03-15T02:09:22.353925Z","caller":"traceutil/trace.go:171","msg":"trace[759661] transaction","detail":"{read_only:false; response_revision:4606; number_of_response:1; }","duration":"238.638788ms","start":"2026-03-15T02:09:22.115258Z","end":"2026-03-15T02:09:22.353897Z","steps":["trace[759661] 'process raft request' (duration: 231.760339ms)"],"step_count":1} {"level":"info","ts":"2026-03-15T02:11:13.717233Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2757} {"level":"info","ts":"2026-03-15T02:11:13.775715Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2757,"took":"56.483622ms","hash":1402719157,"current-db-size-bytes":41254912,"current-db-size":"41 MB","current-db-size-in-use-bytes":30883840,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-03-15T02:11:13.775789Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1402719157,"revision":2757,"compact-revision":-1} {"level":"warn","ts":"2026-03-15T02:16:03.640246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.545442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-03-15T02:16:03.640354Z","caller":"traceutil/trace.go:171","msg":"trace[861391209] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7698; }","duration":"119.718468ms","start":"2026-03-15T02:16:03.520608Z","end":"2026-03-15T02:16:03.640327Z","steps":["trace[861391209] 'range keys from in-memory index tree' (duration: 119.277176ms)"],"step_count":1} {"level":"warn","ts":"2026-03-15T02:16:12.167795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.067598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-2whrw\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-03-15T02:16:12.167964Z","caller":"traceutil/trace.go:171","msg":"trace[1418525170] range","detail":"{range_begin:/registry/pods/openstack/keepalived-2whrw; range_end:; response_count:1; response_revision:7738; }","duration":"177.325945ms","start":"2026-03-15T02:16:11.990612Z","end":"2026-03-15T02:16:12.167937Z","steps":["trace[1418525170] 'range keys from in-memory index tree' (duration: 176.764619ms)"],"step_count":1} {"level":"warn","ts":"2026-03-15T02:16:13.043288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.596604ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-15T02:16:13.043393Z","caller":"traceutil/trace.go:171","msg":"trace[1395336514] linearizableReadLoop","detail":"{readStateIndex:8040; appliedIndex:8039; }","duration":"221.395173ms","start":"2026-03-15T02:16:12.821979Z","end":"2026-03-15T02:16:13.043374Z","steps":["trace[1395336514] 'read index received' (duration: 44.892µs)","trace[1395336514] 'applied index is now lower than readState.Index' (duration: 221.348981ms)"],"step_count":2} {"level":"info","ts":"2026-03-15T02:16:13.043494Z","caller":"traceutil/trace.go:171","msg":"trace[691620883] transaction","detail":"{read_only:false; response_revision:7744; number_of_response:1; }","duration":"261.225596ms","start":"2026-03-15T02:16:12.782255Z","end":"2026-03-15T02:16:13.043481Z","steps":["trace[691620883] 'process raft request' (duration: 34.330834ms)","trace[691620883] 'compare' (duration: 226.378608ms)"],"step_count":2} {"level":"warn","ts":"2026-03-15T02:16:13.043689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.704981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-15T02:16:13.043731Z","caller":"traceutil/trace.go:171","msg":"trace[2066814933] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:7744; }","duration":"221.776993ms","start":"2026-03-15T02:16:12.821939Z","end":"2026-03-15T02:16:13.043716Z","steps":["trace[2066814933] 'agreement among raft nodes before linearized reading' (duration: 221.700081ms)"],"step_count":1} {"level":"info","ts":"2026-03-15T02:16:13.80215Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5729} {"level":"info","ts":"2026-03-15T02:16:13.90132Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5729,"took":"97.053ms","hash":3368751178,"current-db-size-bytes":42999808,"current-db-size":"43 MB","current-db-size-in-use-bytes":23363584,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-03-15T02:16:13.901391Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3368751178,"revision":5729,"compact-revision":2757} {"level":"info","ts":"2026-03-15T02:16:40.177966Z","caller":"traceutil/trace.go:171","msg":"trace[593557995] transaction","detail":"{read_only:false; response_revision:7929; number_of_response:1; }","duration":"231.748274ms","start":"2026-03-15T02:16:39.946186Z","end":"2026-03-15T02:16:40.177934Z","steps":["trace[593557995] 'process raft request' (duration: 231.58146ms)"],"step_count":1} {"level":"info","ts":"2026-03-15T02:16:40.299502Z","caller":"traceutil/trace.go:171","msg":"trace[1966432028] transaction","detail":"{read_only:false; response_revision:7930; number_of_response:1; }","duration":"349.94117ms","start":"2026-03-15T02:16:39.949527Z","end":"2026-03-15T02:16:40.299468Z","steps":["trace[1966432028] 'process raft request' (duration: 347.134524ms)"],"step_count":1} {"level":"info","ts":"2026-03-15T02:16:40.299514Z","caller":"traceutil/trace.go:171","msg":"trace[1645893683] linearizableReadLoop","detail":"{readStateIndex:8234; appliedIndex:8233; }","duration":"326.166794ms","start":"2026-03-15T02:16:39.973301Z","end":"2026-03-15T02:16:40.299468Z","steps":["trace[1645893683] 'read index received' (duration: 204.628857ms)","trace[1645893683] 'applied index is now lower than readState.Index' (duration: 121.536477ms)"],"step_count":2} {"level":"warn","ts":"2026-03-15T02:16:40.29972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-15T02:16:39.949512Z","time spent":"350.112215ms","remote":"127.0.0.1:37882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-15T02:16:40.299829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.756992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-03-15T02:16:40.299828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.888774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-15T02:16:40.299811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.484092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-03-15T02:16:40.29988Z","caller":"traceutil/trace.go:171","msg":"trace[1587685320] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:7930; }","duration":"307.888026ms","start":"2026-03-15T02:16:39.991979Z","end":"2026-03-15T02:16:40.299867Z","steps":["trace[1587685320] 'agreement among raft nodes before linearized reading' (duration: 307.747092ms)"],"step_count":1} {"level":"info","ts":"2026-03-15T02:16:40.299892Z","caller":"traceutil/trace.go:171","msg":"trace[1956446032] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7930; }","duration":"223.001537ms","start":"2026-03-15T02:16:40.076874Z","end":"2026-03-15T02:16:40.299876Z","steps":["trace[1956446032] 'agreement among raft nodes before linearized reading' (duration: 222.869373ms)"],"step_count":1} {"level":"warn","ts":"2026-03-15T02:16:40.299894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.413639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-15T02:16:40.299912Z","caller":"traceutil/trace.go:171","msg":"trace[2058443068] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7930; }","duration":"326.671537ms","start":"2026-03-15T02:16:39.973219Z","end":"2026-03-15T02:16:40.299891Z","steps":["trace[2058443068] 'agreement among raft nodes before linearized reading' (duration: 326.363929ms)"],"step_count":1} {"level":"info","ts":"2026-03-15T02:16:40.299936Z","caller":"traceutil/trace.go:171","msg":"trace[289150433] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:7930; }","duration":"262.471661ms","start":"2026-03-15T02:16:40.037451Z","end":"2026-03-15T02:16:40.299922Z","steps":["trace[289150433] 'agreement among raft nodes before linearized reading' (duration: 262.398289ms)"],"step_count":1} {"level":"warn","ts":"2026-03-15T02:16:40.299939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-15T02:16:39.991954Z","time spent":"307.973548ms","remote":"127.0.0.1:38054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":9,"response size":30,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"warn","ts":"2026-03-15T02:16:40.299975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-15T02:16:39.973179Z","time spent":"326.78691ms","remote":"127.0.0.1:37882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-03-15T02:16:40.300001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.990903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/key-manager.189ce2171a144144\" ","response":"range_response_count:1 size:679"} {"level":"info","ts":"2026-03-15T02:16:40.300083Z","caller":"traceutil/trace.go:171","msg":"trace[1211482946] range","detail":"{range_begin:/registry/events/openstack/key-manager.189ce2171a144144; range_end:; response_count:1; response_revision:7930; }","duration":"117.127997ms","start":"2026-03-15T02:16:40.182931Z","end":"2026-03-15T02:16:40.300059Z","steps":["trace[1211482946] 'agreement among raft nodes before linearized reading' (duration: 116.829839ms)"],"step_count":1} {"level":"info","ts":"2026-03-15T02:16:45.028484Z","caller":"traceutil/trace.go:171","msg":"trace[1715349621] transaction","detail":"{read_only:false; response_revision:7953; number_of_response:1; }","duration":"249.165618ms","start":"2026-03-15T02:16:44.779269Z","end":"2026-03-15T02:16:45.028434Z","steps":["trace[1715349621] 'process raft request' (duration: 207.970237ms)","trace[1715349621] 'compare' (duration: 40.918474ms)"],"step_count":2} {"level":"warn","ts":"2026-03-15T02:16:53.396722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.821547ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-15T02:16:53.396857Z","caller":"traceutil/trace.go:171","msg":"trace[602482312] transaction","detail":"{read_only:false; response_revision:8036; number_of_response:1; }","duration":"200.884646ms","start":"2026-03-15T02:16:53.19595Z","end":"2026-03-15T02:16:53.396834Z","steps":["trace[602482312] 'process raft request' (duration: 90.826552ms)","trace[602482312] 'compare' (duration: 109.619242ms)"],"step_count":2} {"level":"info","ts":"2026-03-15T02:16:53.411637Z","caller":"traceutil/trace.go:171","msg":"trace[1797225287] transaction","detail":"{read_only:false; response_revision:8038; number_of_response:1; }","duration":"153.153606ms","start":"2026-03-15T02:16:53.258453Z","end":"2026-03-15T02:16:53.411607Z","steps":["trace[1797225287] 'process raft request' (duration: 153.057204ms)"],"step_count":1} {"level":"info","ts":"2026-03-15T02:16:53.411753Z","caller":"traceutil/trace.go:171","msg":"trace[335782535] transaction","detail":"{read_only:false; response_revision:8037; number_of_response:1; }","duration":"209.719235ms","start":"2026-03-15T02:16:53.201952Z","end":"2026-03-15T02:16:53.411671Z","steps":["trace[335782535] 'process raft request' (duration: 209.366825ms)"],"step_count":1} {"level":"info","ts":"2026-03-15T02:16:54.179879Z","caller":"traceutil/trace.go:171","msg":"trace[337804019] transaction","detail":"{read_only:false; response_revision:8039; number_of_response:1; }","duration":"187.675445ms","start":"2026-03-15T02:16:53.992181Z","end":"2026-03-15T02:16:54.179857Z","steps":["trace[337804019] 'process raft request' (duration: 187.554862ms)"],"step_count":1} {"level":"info","ts":"2026-03-15T02:16:54.179903Z","caller":"traceutil/trace.go:171","msg":"trace[1265034199] linearizableReadLoop","detail":"{readStateIndex:8349; appliedIndex:8348; }","duration":"160.98767ms","start":"2026-03-15T02:16:54.018867Z","end":"2026-03-15T02:16:54.179855Z","steps":["trace[1265034199] 'read index received' (duration: 160.96491ms)","trace[1265034199] 'applied index is now lower than readState.Index' (duration: 19.19µs)"],"step_count":2} {"level":"warn","ts":"2026-03-15T02:16:54.180235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.617326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-15T02:16:54.180298Z","caller":"traceutil/trace.go:171","msg":"trace[144143613] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8039; }","duration":"104.779451ms","start":"2026-03-15T02:16:54.075501Z","end":"2026-03-15T02:16:54.18028Z","steps":["trace[144143613] 'agreement among raft nodes before linearized reading' (duration: 104.553764ms)"],"step_count":1} {"level":"warn","ts":"2026-03-15T02:16:54.180756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.811663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:5146"} {"level":"info","ts":"2026-03-15T02:16:54.180872Z","caller":"traceutil/trace.go:171","msg":"trace[758117729] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:8039; }","duration":"162.046819ms","start":"2026-03-15T02:16:54.018801Z","end":"2026-03-15T02:16:54.180848Z","steps":["trace[758117729] 'agreement among raft nodes before linearized reading' (duration: 161.488704ms)"],"step_count":1} {"level":"warn","ts":"2026-03-15T02:16:54.564915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.951506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-03-15T02:16:54.56539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.517056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-15T02:16:54.565883Z","caller":"traceutil/trace.go:171","msg":"trace[988241178] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8041; }","duration":"169.159292ms","start":"2026-03-15T02:16:54.395892Z","end":"2026-03-15T02:16:54.565051Z","steps":["trace[988241178] 'range keys from in-memory index tree' (duration: 168.69704ms)"],"step_count":1} {"level":"info","ts":"2026-03-15T02:16:54.566049Z","caller":"traceutil/trace.go:171","msg":"trace[966758344] linearizableReadLoop","detail":"{readStateIndex:8352; appliedIndex:8351; }","duration":"103.421654ms","start":"2026-03-15T02:16:54.461856Z","end":"2026-03-15T02:16:54.565278Z","steps":["trace[966758344] 'read index received' (duration: 74.041565ms)","trace[966758344] 'applied index is now lower than readState.Index' (duration: 29.378839ms)"],"step_count":2} {"level":"info","ts":"2026-03-15T02:16:54.566129Z","caller":"traceutil/trace.go:171","msg":"trace[409619722] transaction","detail":"{read_only:false; response_revision:8042; number_of_response:1; }","duration":"116.961192ms","start":"2026-03-15T02:16:54.448478Z","end":"2026-03-15T02:16:54.565439Z","steps":["trace[409619722] 'process raft request' (duration: 87.405059ms)","trace[409619722] 'compare' (duration: 28.914916ms)"],"step_count":2} {"level":"info","ts":"2026-03-15T02:16:54.56651Z","caller":"traceutil/trace.go:171","msg":"trace[489663753] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:8042; }","duration":"103.65073ms","start":"2026-03-15T02:16:54.461794Z","end":"2026-03-15T02:16:54.565445Z","steps":["trace[489663753] 'agreement among raft nodes before linearized reading' (duration: 103.488355ms)"],"step_count":1} {"level":"info","ts":"2026-03-15T02:20:34.322106Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"f52f30d5714009d5","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-03-15T02:20:34.328334Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-03-15T02:20:34.328427Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-03-15T02:21:13.809527Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7745} {"level":"info","ts":"2026-03-15T02:21:13.873894Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7745,"took":"61.384687ms","hash":1274724073,"current-db-size-bytes":42999808,"current-db-size":"43 MB","current-db-size-in-use-bytes":25292800,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-03-15T02:21:13.873971Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1274724073,"revision":7745,"compact-revision":5729} {"level":"info","ts":"2026-03-15T02:26:13.818148Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9821} {"level":"info","ts":"2026-03-15T02:26:13.897708Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9821,"took":"76.631485ms","hash":2620487614,"current-db-size-bytes":42999808,"current-db-size":"43 MB","current-db-size-in-use-bytes":17981440,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-03-15T02:26:13.897795Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2620487614,"revision":9821,"compact-revision":7745}