{"level":"warn","ts":"2026-10-16T11:10:15.283551Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-16T11:10:15.283682Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.36: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.36:2380","--initial-cluster=instance=https://162.253.55.36:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.36:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.36: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-10-16T11:10:15.283762Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-16T11:10:15.283778Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.36:2380"]} {"level":"info","ts":"2026-10-16T11:10:15.283801Z","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-10-16T11:10:15.28478Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.36:2379"]} {"level":"info","ts":"2026-10-16T11:10:15.284877Z","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.36:2380"],"listen-peer-urls":["https://162.253.55.36:2380"],"advertise-client-urls":["https://162.253.55.36:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.36:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.36: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-10-16T11:10:15.287892Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.720937ms"} {"level":"info","ts":"2026-10-16T11:10:15.293648Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cb89ec34a9687f0b","cluster-id":"d8e0d5e222e856c9"} {"level":"info","ts":"2026-10-16T11:10:15.29373Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b switched to configuration voters=()"} {"level":"info","ts":"2026-10-16T11:10:15.293761Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b became follower at term 0"} {"level":"info","ts":"2026-10-16T11:10:15.293785Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cb89ec34a9687f0b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-16T11:10:15.293801Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b became follower at term 1"} {"level":"info","ts":"2026-10-16T11:10:15.293852Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b switched to configuration voters=(14666513372433383179)"} {"level":"warn","ts":"2026-10-16T11:10:15.300133Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-16T11:10:15.302182Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-16T11:10:15.305133Z","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-10-16T11:10:15.308943Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cb89ec34a9687f0b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-16T11:10:15.309115Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cb89ec34a9687f0b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-16T11:10:15.309232Z","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-10-16T11:10:15.309369Z","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-10-16T11:10:15.309392Z","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-10-16T11:10:15.312341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b switched to configuration voters=(14666513372433383179)"} {"level":"info","ts":"2026-10-16T11:10:15.312706Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"d8e0d5e222e856c9","local-member-id":"cb89ec34a9687f0b","added-peer-id":"cb89ec34a9687f0b","added-peer-peer-urls":["https://162.253.55.36:2380"]} {"level":"info","ts":"2026-10-16T11:10:15.318318Z","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-10-16T11:10:15.318457Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.36:2380"} {"level":"info","ts":"2026-10-16T11:10:15.318493Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.36:2380"} {"level":"info","ts":"2026-10-16T11:10:15.318769Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cb89ec34a9687f0b","initial-advertise-peer-urls":["https://162.253.55.36:2380"],"listen-peer-urls":["https://162.253.55.36:2380"],"advertise-client-urls":["https://162.253.55.36:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.36:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-16T11:10:15.318838Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-16T11:10:15.894503Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b is starting a new election at term 1"} {"level":"info","ts":"2026-10-16T11:10:15.894591Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b became pre-candidate at term 1"} {"level":"info","ts":"2026-10-16T11:10:15.894635Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b received MsgPreVoteResp from cb89ec34a9687f0b at term 1"} {"level":"info","ts":"2026-10-16T11:10:15.894655Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b became candidate at term 2"} {"level":"info","ts":"2026-10-16T11:10:15.894666Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b received MsgVoteResp from cb89ec34a9687f0b at term 2"} {"level":"info","ts":"2026-10-16T11:10:15.894681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb89ec34a9687f0b became leader at term 2"} {"level":"info","ts":"2026-10-16T11:10:15.894693Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cb89ec34a9687f0b elected leader cb89ec34a9687f0b at term 2"} {"level":"info","ts":"2026-10-16T11:10:15.89577Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-16T11:10:15.897349Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-16T11:10:15.897347Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cb89ec34a9687f0b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.36:2379]}","request-path":"/0/members/cb89ec34a9687f0b/attributes","cluster-id":"d8e0d5e222e856c9","publish-timeout":"7s"} {"level":"info","ts":"2026-10-16T11:10:15.89739Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-16T11:10:15.897691Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-16T11:10:15.897759Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-16T11:10:15.89803Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"d8e0d5e222e856c9","local-member-id":"cb89ec34a9687f0b","cluster-version":"3.5"} {"level":"info","ts":"2026-10-16T11:10:15.898163Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-16T11:10:15.898198Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-16T11:10:15.900599Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.36:2379"} {"level":"info","ts":"2026-10-16T11:10:15.900669Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-16T11:10:29.901664Z","caller":"traceutil/trace.go:171","msg":"trace[2037250595] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"119.223102ms","start":"2026-10-16T11:10:29.782393Z","end":"2026-10-16T11:10:29.901616Z","steps":["trace[2037250595] 'process raft request' (duration: 118.985565ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:10:30.217408Z","caller":"traceutil/trace.go:171","msg":"trace[1482695782] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"264.655881ms","start":"2026-10-16T11:10:29.952712Z","end":"2026-10-16T11:10:30.217368Z","steps":["trace[1482695782] 'process raft request' (duration: 264.215818ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:10:30.428993Z","caller":"traceutil/trace.go:171","msg":"trace[1087012147] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"198.154763ms","start":"2026-10-16T11:10:30.23082Z","end":"2026-10-16T11:10:30.428975Z","steps":["trace[1087012147] 'process raft request' (duration: 196.843496ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:10:30.430342Z","caller":"traceutil/trace.go:171","msg":"trace[2035958641] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"194.208521ms","start":"2026-10-16T11:10:30.236093Z","end":"2026-10-16T11:10:30.430302Z","steps":["trace[2035958641] 'process raft request' (duration: 194.012875ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:11:04.920602Z","caller":"traceutil/trace.go:171","msg":"trace[316714566] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:667; }","duration":"154.069343ms","start":"2026-10-16T11:11:04.766504Z","end":"2026-10-16T11:11:04.920574Z","steps":["trace[316714566] 'read index received' (duration: 152.56507ms)","trace[316714566] 'applied index is now lower than readState.Index' (duration: 1.502943ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T11:11:04.920705Z","caller":"traceutil/trace.go:171","msg":"trace[1672772721] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"161.05658ms","start":"2026-10-16T11:11:04.759596Z","end":"2026-10-16T11:11:04.920652Z","steps":["trace[1672772721] 'process raft request' (duration: 159.655951ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:11:04.920892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.301689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-16T11:11:04.920975Z","caller":"traceutil/trace.go:171","msg":"trace[1801518520] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:642; }","duration":"154.469554ms","start":"2026-10-16T11:11:04.766491Z","end":"2026-10-16T11:11:04.92096Z","steps":["trace[1801518520] 'agreement among raft nodes before linearized reading' (duration: 154.259168ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:11:04.920953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.750785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T11:11:04.921055Z","caller":"traceutil/trace.go:171","msg":"trace[82819374] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:642; }","duration":"135.985132ms","start":"2026-10-16T11:11:04.785045Z","end":"2026-10-16T11:11:04.92103Z","steps":["trace[82819374] 'agreement among raft nodes before linearized reading' (duration: 135.777926ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:11:05.562119Z","caller":"traceutil/trace.go:171","msg":"trace[1243610881] linearizableReadLoop","detail":"{readStateIndex:671; appliedIndex:670; }","duration":"438.048829ms","start":"2026-10-16T11:11:05.124004Z","end":"2026-10-16T11:11:05.562053Z","steps":["trace[1243610881] 'read index received' (duration: 432.181293ms)","trace[1243610881] 'applied index is now lower than readState.Index' (duration: 5.865976ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T11:11:05.562259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.245574ms","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-10-16T11:11:05.562299Z","caller":"traceutil/trace.go:171","msg":"trace[1155872670] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:645; }","duration":"438.300726ms","start":"2026-10-16T11:11:05.123984Z","end":"2026-10-16T11:11:05.562285Z","steps":["trace[1155872670] 'agreement among raft nodes before linearized reading' (duration: 438.195963ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:11:05.562275Z","caller":"traceutil/trace.go:171","msg":"trace[445261360] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"452.9334ms","start":"2026-10-16T11:11:05.109174Z","end":"2026-10-16T11:11:05.562108Z","steps":["trace[445261360] 'process raft request' (duration: 446.93692ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:11:05.562351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T11:11:05.123911Z","time spent":"438.41757ms","remote":"127.0.0.1:37944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-16T11:11:05.563008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T11:11:05.109148Z","time spent":"453.29607ms","remote":"127.0.0.1:37872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T11:11:21.130829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.013118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-16T11:11:21.131033Z","caller":"traceutil/trace.go:171","msg":"trace[1574849097] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:811; }","duration":"122.212783ms","start":"2026-10-16T11:11:21.00876Z","end":"2026-10-16T11:11:21.130972Z","steps":["trace[1574849097] 'range keys from in-memory index tree' (duration: 121.760521ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:12:39.930522Z","caller":"traceutil/trace.go:171","msg":"trace[738207805] linearizableReadLoop","detail":"{readStateIndex:1967; appliedIndex:1966; }","duration":"146.66988ms","start":"2026-10-16T11:12:39.783817Z","end":"2026-10-16T11:12:39.930487Z","steps":["trace[738207805] 'read index received' (duration: 146.434223ms)","trace[738207805] 'applied index is now lower than readState.Index' (duration: 234.817µs)"],"step_count":2} {"level":"info","ts":"2026-10-16T11:12:39.930583Z","caller":"traceutil/trace.go:171","msg":"trace[2135642382] transaction","detail":"{read_only:false; response_revision:1895; number_of_response:1; }","duration":"366.150929ms","start":"2026-10-16T11:12:39.564406Z","end":"2026-10-16T11:12:39.930557Z","steps":["trace[2135642382] 'process raft request' (duration: 365.915772ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:12:39.930686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.870305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T11:12:39.930751Z","caller":"traceutil/trace.go:171","msg":"trace[709503796] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1895; }","duration":"146.938777ms","start":"2026-10-16T11:12:39.783799Z","end":"2026-10-16T11:12:39.930737Z","steps":["trace[709503796] 'agreement among raft nodes before linearized reading' (duration: 146.841864ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:12:39.930773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.943702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-16T11:12:39.930847Z","caller":"traceutil/trace.go:171","msg":"trace[1170121843] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1895; }","duration":"123.077156ms","start":"2026-10-16T11:12:39.807751Z","end":"2026-10-16T11:12:39.930828Z","steps":["trace[1170121843] 'agreement among raft nodes before linearized reading' (duration: 122.931251ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:12:39.93123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T11:12:39.564372Z","time spent":"366.260532ms","remote":"127.0.0.1:37872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3728,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T11:12:54.662736Z","caller":"traceutil/trace.go:171","msg":"trace[30550167] transaction","detail":"{read_only:false; response_revision:2023; number_of_response:1; }","duration":"128.092556ms","start":"2026-10-16T11:12:54.534587Z","end":"2026-10-16T11:12:54.662679Z","steps":["trace[30550167] 'process raft request' (duration: 127.940632ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:12:54.66422Z","caller":"traceutil/trace.go:171","msg":"trace[1825242098] transaction","detail":"{read_only:false; response_revision:2024; number_of_response:1; }","duration":"118.955459ms","start":"2026-10-16T11:12:54.545249Z","end":"2026-10-16T11:12:54.664204Z","steps":["trace[1825242098] 'process raft request' (duration: 118.857217ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:13:34.651936Z","caller":"traceutil/trace.go:171","msg":"trace[1579928942] transaction","detail":"{read_only:false; response_revision:2241; number_of_response:1; }","duration":"265.937409ms","start":"2026-10-16T11:13:34.385955Z","end":"2026-10-16T11:13:34.651893Z","steps":["trace[1579928942] 'process raft request' (duration: 265.658151ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:13:34.915503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.083908ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-10-16T11:13:34.915665Z","caller":"traceutil/trace.go:171","msg":"trace[1906252329] linearizableReadLoop","detail":"{readStateIndex:2325; appliedIndex:2323; }","duration":"333.044276ms","start":"2026-10-16T11:13:34.582599Z","end":"2026-10-16T11:13:34.915643Z","steps":["trace[1906252329] 'read index received' (duration: 68.437374ms)","trace[1906252329] 'applied index is now lower than readState.Index' (duration: 264.604882ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T11:13:34.915813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.19947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-16T11:13:34.915849Z","caller":"traceutil/trace.go:171","msg":"trace[853367530] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:2241; }","duration":"333.285452ms","start":"2026-10-16T11:13:34.582555Z","end":"2026-10-16T11:13:34.91584Z","steps":["trace[853367530] 'agreement among raft nodes before linearized reading' (duration: 333.177359ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:13:34.915893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T11:13:34.582536Z","time spent":"333.347244ms","remote":"127.0.0.1:37850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":31,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"info","ts":"2026-10-16T11:13:34.984154Z","caller":"traceutil/trace.go:171","msg":"trace[1286867674] transaction","detail":"{read_only:false; response_revision:2242; number_of_response:1; }","duration":"178.818272ms","start":"2026-10-16T11:13:34.805284Z","end":"2026-10-16T11:13:34.984102Z","steps":["trace[1286867674] 'process raft request' (duration: 178.607576ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:13:35.084854Z","caller":"traceutil/trace.go:171","msg":"trace[427453681] linearizableReadLoop","detail":"{readStateIndex:2328; appliedIndex:2325; }","duration":"169.140381ms","start":"2026-10-16T11:13:34.915695Z","end":"2026-10-16T11:13:35.084835Z","steps":["trace[427453681] 'read index received' (duration: 68.188368ms)","trace[427453681] 'applied index is now lower than readState.Index' (duration: 100.950893ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T11:13:35.084975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.138984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T11:13:35.085008Z","caller":"traceutil/trace.go:171","msg":"trace[1611294653] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2244; }","duration":"301.227886ms","start":"2026-10-16T11:13:34.783772Z","end":"2026-10-16T11:13:35.085Z","steps":["trace[1611294653] 'agreement among raft nodes before linearized reading' (duration: 301.140614ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:13:35.08504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T11:13:34.783725Z","time spent":"301.308298ms","remote":"127.0.0.1:37704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-16T11:13:35.085234Z","caller":"traceutil/trace.go:171","msg":"trace[483830266] transaction","detail":"{read_only:false; response_revision:2244; number_of_response:1; }","duration":"247.255796ms","start":"2026-10-16T11:13:34.837921Z","end":"2026-10-16T11:13:35.085177Z","steps":["trace[483830266] 'process raft request' (duration: 246.867865ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:13:35.085428Z","caller":"traceutil/trace.go:171","msg":"trace[1466403428] transaction","detail":"{read_only:false; response_revision:2243; number_of_response:1; }","duration":"276.630378ms","start":"2026-10-16T11:13:34.80877Z","end":"2026-10-16T11:13:35.0854Z","steps":["trace[1466403428] 'process raft request' (duration: 255.221199ms)","trace[1466403428] 'compare' (duration: 20.670729ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T11:13:35.085437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.031416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-16T11:13:35.085512Z","caller":"traceutil/trace.go:171","msg":"trace[717045322] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2244; }","duration":"175.1612ms","start":"2026-10-16T11:13:34.910331Z","end":"2026-10-16T11:13:35.085492Z","steps":["trace[717045322] 'agreement among raft nodes before linearized reading' (duration: 174.871232ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:14:09.785123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.599939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-16T11:14:09.785216Z","caller":"traceutil/trace.go:171","msg":"trace[1164792418] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:2608; }","duration":"112.746734ms","start":"2026-10-16T11:14:09.672452Z","end":"2026-10-16T11:14:09.785198Z","steps":["trace[1164792418] 'count revisions from in-memory index tree' (duration: 112.476886ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:14:43.494358Z","caller":"traceutil/trace.go:171","msg":"trace[1709978071] transaction","detail":"{read_only:false; response_revision:2812; number_of_response:1; }","duration":"169.074177ms","start":"2026-10-16T11:14:43.325258Z","end":"2026-10-16T11:14:43.494333Z","steps":["trace[1709978071] 'process raft request' (duration: 168.904562ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:14:43.498712Z","caller":"traceutil/trace.go:171","msg":"trace[1014067534] transaction","detail":"{read_only:false; response_revision:2813; number_of_response:1; }","duration":"163.319296ms","start":"2026-10-16T11:14:43.335366Z","end":"2026-10-16T11:14:43.498685Z","steps":["trace[1014067534] 'process raft request' (duration: 163.140951ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:14:43.498933Z","caller":"traceutil/trace.go:171","msg":"trace[927505168] transaction","detail":"{read_only:false; response_revision:2814; number_of_response:1; }","duration":"157.635226ms","start":"2026-10-16T11:14:43.341275Z","end":"2026-10-16T11:14:43.498911Z","steps":["trace[927505168] 'process raft request' (duration: 157.364418ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:17:18.690518Z","caller":"traceutil/trace.go:171","msg":"trace[425180096] transaction","detail":"{read_only:false; response_revision:3774; number_of_response:1; }","duration":"105.865589ms","start":"2026-10-16T11:17:18.584631Z","end":"2026-10-16T11:17:18.690497Z","steps":["trace[425180096] 'process raft request' (duration: 98.686971ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:19:18.92295Z","caller":"traceutil/trace.go:171","msg":"trace[1396740632] transaction","detail":"{read_only:false; response_revision:5073; number_of_response:1; }","duration":"100.43969ms","start":"2026-10-16T11:19:18.822481Z","end":"2026-10-16T11:19:18.922921Z","steps":["trace[1396740632] 'process raft request' (duration: 100.182183ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:19:22.836642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.95686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-93d3901f-fda8-4c98-b7e3-b55f6f53e219\" ","response":"range_response_count:1 size:3600"} {"level":"info","ts":"2026-10-16T11:19:22.836728Z","caller":"traceutil/trace.go:171","msg":"trace[1154692325] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-93d3901f-fda8-4c98-b7e3-b55f6f53e219; range_end:; response_count:1; response_revision:5207; }","duration":"224.073164ms","start":"2026-10-16T11:19:22.612634Z","end":"2026-10-16T11:19:22.836707Z","steps":["trace[1154692325] 'range keys from in-memory index tree' (duration: 223.825637ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:19:22.836885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.307928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T11:19:22.836913Z","caller":"traceutil/trace.go:171","msg":"trace[173759399] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:5207; }","duration":"182.336838ms","start":"2026-10-16T11:19:22.654564Z","end":"2026-10-16T11:19:22.836901Z","steps":["trace[173759399] 'count revisions from in-memory index tree' (duration: 182.186943ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:19:24.966173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.798889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T11:19:24.966253Z","caller":"traceutil/trace.go:171","msg":"trace[834328475] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5245; }","duration":"183.922472ms","start":"2026-10-16T11:19:24.782313Z","end":"2026-10-16T11:19:24.966235Z","steps":["trace[834328475] 'range keys from in-memory index tree' (duration: 183.713736ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:19:24.967117Z","caller":"traceutil/trace.go:171","msg":"trace[1850522567] transaction","detail":"{read_only:false; response_revision:5246; number_of_response:1; }","duration":"133.553528ms","start":"2026-10-16T11:19:24.833546Z","end":"2026-10-16T11:19:24.9671Z","steps":["trace[1850522567] 'process raft request' (duration: 115.298102ms)","trace[1850522567] 'compare' (duration: 17.919397ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T11:19:37.600388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.207703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-16T11:19:37.600499Z","caller":"traceutil/trace.go:171","msg":"trace[1720429915] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5476; }","duration":"118.372667ms","start":"2026-10-16T11:19:37.482105Z","end":"2026-10-16T11:19:37.600478Z","steps":["trace[1720429915] 'range keys from in-memory index tree' (duration: 118.020218ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:19:37.600483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.510303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-10-16T11:19:37.600571Z","caller":"traceutil/trace.go:171","msg":"trace[1502404607] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5476; }","duration":"117.633677ms","start":"2026-10-16T11:19:37.482918Z","end":"2026-10-16T11:19:37.600552Z","steps":["trace[1502404607] 'range keys from in-memory index tree' (duration: 117.336829ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:19:38.374061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.672058ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-16T11:19:38.374249Z","caller":"traceutil/trace.go:171","msg":"trace[133634040] linearizableReadLoop","detail":"{readStateIndex:5691; appliedIndex:5688; }","duration":"320.562245ms","start":"2026-10-16T11:19:38.053674Z","end":"2026-10-16T11:19:38.374236Z","steps":["trace[133634040] 'read index received' (duration: 202.60179ms)","trace[133634040] 'applied index is now lower than readState.Index' (duration: 117.959785ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T11:19:38.374355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.679678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-lvcck\" ","response":"range_response_count:1 size:6526"} {"level":"info","ts":"2026-10-16T11:19:38.374374Z","caller":"traceutil/trace.go:171","msg":"trace[1361039787] range","detail":"{range_begin:/registry/pods/openstack/keepalived-lvcck; range_end:; response_count:1; response_revision:5484; }","duration":"320.72636ms","start":"2026-10-16T11:19:38.053639Z","end":"2026-10-16T11:19:38.374365Z","steps":["trace[1361039787] 'agreement among raft nodes before linearized reading' (duration: 320.631787ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:19:38.374396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T11:19:38.05362Z","time spent":"320.771121ms","remote":"127.0.0.1:37872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6550,"request content":"key:\"/registry/pods/openstack/keepalived-lvcck\" "} {"level":"info","ts":"2026-10-16T11:19:38.374374Z","caller":"traceutil/trace.go:171","msg":"trace[5990703] transaction","detail":"{read_only:false; response_revision:5483; number_of_response:1; }","duration":"547.128678ms","start":"2026-10-16T11:19:37.827217Z","end":"2026-10-16T11:19:38.374345Z","steps":["trace[5990703] 'process raft request' (duration: 546.927163ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:19:38.374532Z","caller":"traceutil/trace.go:171","msg":"trace[1831430341] transaction","detail":"{read_only:false; response_revision:5484; number_of_response:1; }","duration":"547.117747ms","start":"2026-10-16T11:19:37.827407Z","end":"2026-10-16T11:19:38.374524Z","steps":["trace[1831430341] 'process raft request' (duration: 546.789888ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:19:38.374562Z","caller":"traceutil/trace.go:171","msg":"trace[576588409] transaction","detail":"{read_only:false; response_revision:5482; number_of_response:1; }","duration":"547.422476ms","start":"2026-10-16T11:19:37.827128Z","end":"2026-10-16T11:19:38.37455Z","steps":["trace[576588409] 'process raft request' (duration: 429.170742ms)","trace[576588409] 'compare' (duration: 117.361329ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T11:19:38.374573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T11:19:37.827396Z","time spent":"547.156069ms","remote":"127.0.0.1:37858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":682,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T11:19:38.374608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T11:19:37.827112Z","time spent":"547.472327ms","remote":"127.0.0.1:37952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1068,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T11:19:38.374519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T11:19:37.827209Z","time spent":"547.230731ms","remote":"127.0.0.1:37952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1039,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T11:19:45.842776Z","caller":"traceutil/trace.go:171","msg":"trace[1256227728] transaction","detail":"{read_only:false; response_revision:5658; number_of_response:1; }","duration":"147.061572ms","start":"2026-10-16T11:19:45.695678Z","end":"2026-10-16T11:19:45.84274Z","steps":["trace[1256227728] 'process raft request' (duration: 103.787553ms)","trace[1256227728] 'compare' (duration: 43.143705ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T11:20:15.925745Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2992} {"level":"info","ts":"2026-10-16T11:20:16.008704Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2992,"took":"81.529537ms","hash":116752755,"current-db-size-bytes":57417728,"current-db-size":"57 MB","current-db-size-in-use-bytes":32845824,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-16T11:20:16.008776Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":116752755,"revision":2992,"compact-revision":-1} {"level":"info","ts":"2026-10-16T11:20:50.945302Z","caller":"traceutil/trace.go:171","msg":"trace[788128653] transaction","detail":"{read_only:false; response_revision:6249; number_of_response:1; }","duration":"105.752944ms","start":"2026-10-16T11:20:50.839512Z","end":"2026-10-16T11:20:50.945265Z","steps":["trace[788128653] 'process raft request' (duration: 71.754844ms)","trace[788128653] 'compare' (duration: 33.721293ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T11:25:15.93309Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5927} {"level":"info","ts":"2026-10-16T11:25:16.022569Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5927,"took":"87.550507ms","hash":789278263,"current-db-size-bytes":57417728,"current-db-size":"57 MB","current-db-size-in-use-bytes":26255360,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-16T11:25:16.02264Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":789278263,"revision":5927,"compact-revision":2992} {"level":"info","ts":"2026-10-16T11:26:10.665137Z","caller":"traceutil/trace.go:171","msg":"trace[372506704] transaction","detail":"{read_only:false; response_revision:8569; number_of_response:1; }","duration":"211.481069ms","start":"2026-10-16T11:26:10.45361Z","end":"2026-10-16T11:26:10.665091Z","steps":["trace[372506704] 'process raft request' (duration: 211.349506ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:26:10.906163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.635409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T11:26:10.906361Z","caller":"traceutil/trace.go:171","msg":"trace[476024446] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8569; }","duration":"121.897286ms","start":"2026-10-16T11:26:10.78443Z","end":"2026-10-16T11:26:10.906327Z","steps":["trace[476024446] 'range keys from in-memory index tree' (duration: 121.502944ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:26:10.906519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.538503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-lvcck\" ","response":"range_response_count:1 size:6526"} {"level":"info","ts":"2026-10-16T11:26:10.906657Z","caller":"traceutil/trace.go:171","msg":"trace[682814228] range","detail":"{range_begin:/registry/pods/openstack/keepalived-lvcck; range_end:; response_count:1; response_revision:8569; }","duration":"147.747439ms","start":"2026-10-16T11:26:10.758878Z","end":"2026-10-16T11:26:10.906626Z","steps":["trace[682814228] 'range keys from in-memory index tree' (duration: 147.253356ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:26:21.101121Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000022e7.wal"} {"level":"info","ts":"2026-10-16T11:26:21.929875Z","caller":"traceutil/trace.go:171","msg":"trace[1021220817] transaction","detail":"{read_only:false; response_revision:8626; number_of_response:1; }","duration":"103.268151ms","start":"2026-10-16T11:26:21.826578Z","end":"2026-10-16T11:26:21.929846Z","steps":["trace[1021220817] 'process raft request' (duration: 103.037185ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:26:21.943755Z","caller":"traceutil/trace.go:171","msg":"trace[1396983604] transaction","detail":"{read_only:false; response_revision:8627; number_of_response:1; }","duration":"114.057109ms","start":"2026-10-16T11:26:21.829672Z","end":"2026-10-16T11:26:21.943729Z","steps":["trace[1396983604] 'process raft request' (duration: 113.857794ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:26:22.662425Z","caller":"traceutil/trace.go:171","msg":"trace[688420122] transaction","detail":"{read_only:false; response_revision:8633; number_of_response:1; }","duration":"246.181047ms","start":"2026-10-16T11:26:22.416217Z","end":"2026-10-16T11:26:22.662398Z","steps":["trace[688420122] 'process raft request' (duration: 245.991742ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:26:51.017281Z","caller":"traceutil/trace.go:171","msg":"trace[1813856565] transaction","detail":"{read_only:false; response_revision:8837; number_of_response:1; }","duration":"211.834889ms","start":"2026-10-16T11:26:50.805424Z","end":"2026-10-16T11:26:51.017259Z","steps":["trace[1813856565] 'process raft request' (duration: 211.651244ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:26:54.224745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.248619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-10-16T11:26:54.224842Z","caller":"traceutil/trace.go:171","msg":"trace[1161662281] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8850; }","duration":"112.392573ms","start":"2026-10-16T11:26:54.112427Z","end":"2026-10-16T11:26:54.22482Z","steps":["trace[1161662281] 'range keys from in-memory index tree' (duration: 112.096786ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:26:54.224972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.622586ms","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-10-16T11:26:54.225031Z","caller":"traceutil/trace.go:171","msg":"trace[766315960] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8850; }","duration":"105.699388ms","start":"2026-10-16T11:26:54.11931Z","end":"2026-10-16T11:26:54.225009Z","steps":["trace[766315960] 'range keys from in-memory index tree' (duration: 105.504303ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:28:15.498346Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"cb89ec34a9687f0b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-16T11:28:15.504933Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-16T11:28:15.505035Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-10-16T11:28:32.88564Z","caller":"traceutil/trace.go:171","msg":"trace[1193975497] transaction","detail":"{read_only:false; response_revision:9759; number_of_response:1; }","duration":"100.861629ms","start":"2026-10-16T11:28:32.784757Z","end":"2026-10-16T11:28:32.885619Z","steps":["trace[1193975497] 'process raft request' (duration: 100.718345ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:28:32.885814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.818617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T11:28:32.885925Z","caller":"traceutil/trace.go:171","msg":"trace[1430571399] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:9759; }","duration":"100.972382ms","start":"2026-10-16T11:28:32.784929Z","end":"2026-10-16T11:28:32.885901Z","steps":["trace[1430571399] 'agreement among raft nodes before linearized reading' (duration: 100.766936ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:28:33.07043Z","caller":"traceutil/trace.go:171","msg":"trace[1928791290] transaction","detail":"{read_only:false; response_revision:9760; number_of_response:1; }","duration":"176.689216ms","start":"2026-10-16T11:28:32.893709Z","end":"2026-10-16T11:28:33.070398Z","steps":["trace[1928791290] 'process raft request' (duration: 175.186554ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:30:15.940203Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8081} {"level":"info","ts":"2026-10-16T11:30:16.012919Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8081,"took":"70.537118ms","hash":850840336,"current-db-size-bytes":57417728,"current-db-size":"57 MB","current-db-size-in-use-bytes":28184576,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-16T11:30:16.012997Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":850840336,"revision":8081,"compact-revision":5927} {"level":"info","ts":"2026-10-16T11:34:11.720615Z","caller":"traceutil/trace.go:171","msg":"trace[695055229] linearizableReadLoop","detail":"{readStateIndex:12614; appliedIndex:12613; }","duration":"109.193307ms","start":"2026-10-16T11:34:11.611394Z","end":"2026-10-16T11:34:11.720588Z","steps":["trace[695055229] 'read index received' (duration: 109.036532ms)","trace[695055229] 'applied index is now lower than readState.Index' (duration: 155.865µs)"],"step_count":2} {"level":"info","ts":"2026-10-16T11:34:11.720752Z","caller":"traceutil/trace.go:171","msg":"trace[205600973] transaction","detail":"{read_only:false; response_revision:12190; number_of_response:1; }","duration":"132.314425ms","start":"2026-10-16T11:34:11.5884Z","end":"2026-10-16T11:34:11.720715Z","steps":["trace[205600973] 'process raft request' (duration: 131.985786ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:34:11.720841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.430203ms","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-10-16T11:34:11.720921Z","caller":"traceutil/trace.go:171","msg":"trace[711430315] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:12190; }","duration":"109.565656ms","start":"2026-10-16T11:34:11.611333Z","end":"2026-10-16T11:34:11.720899Z","steps":["trace[711430315] 'agreement among raft nodes before linearized reading' (duration: 109.425822ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:34:11.78606Z","caller":"traceutil/trace.go:171","msg":"trace[1550906662] transaction","detail":"{read_only:false; response_revision:12191; number_of_response:1; }","duration":"157.432439ms","start":"2026-10-16T11:34:11.628588Z","end":"2026-10-16T11:34:11.786021Z","steps":["trace[1550906662] 'process raft request' (duration: 157.222424ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:34:12.866835Z","caller":"traceutil/trace.go:171","msg":"trace[1760495079] transaction","detail":"{read_only:false; response_revision:12197; number_of_response:1; }","duration":"199.908272ms","start":"2026-10-16T11:34:12.666866Z","end":"2026-10-16T11:34:12.866774Z","steps":["trace[1760495079] 'process raft request' (duration: 186.282206ms)","trace[1760495079] 'compare' (duration: 13.279527ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T11:34:12.866824Z","caller":"traceutil/trace.go:171","msg":"trace[1204805045] linearizableReadLoop","detail":"{readStateIndex:12621; appliedIndex:12620; }","duration":"164.509194ms","start":"2026-10-16T11:34:12.702243Z","end":"2026-10-16T11:34:12.866752Z","steps":["trace[1204805045] 'read index received' (duration: 150.93655ms)","trace[1204805045] 'applied index is now lower than readState.Index' (duration: 13.569814ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T11:34:12.86706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.790933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-10-16T11:34:12.867159Z","caller":"traceutil/trace.go:171","msg":"trace[129086872] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:12197; }","duration":"164.953907ms","start":"2026-10-16T11:34:12.702175Z","end":"2026-10-16T11:34:12.867129Z","steps":["trace[129086872] 'agreement among raft nodes before linearized reading' (duration: 164.70348ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:34:12.867331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.369812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/cinder-api\" ","response":"range_response_count:1 size:667"} {"level":"info","ts":"2026-10-16T11:34:12.867398Z","caller":"traceutil/trace.go:171","msg":"trace[983283782] range","detail":"{range_begin:/registry/services/endpoints/openstack/cinder-api; range_end:; response_count:1; response_revision:12197; }","duration":"155.499336ms","start":"2026-10-16T11:34:12.711878Z","end":"2026-10-16T11:34:12.867378Z","steps":["trace[983283782] 'agreement among raft nodes before linearized reading' (duration: 155.147006ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:34:12.867454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.159435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:1 size:5077"} {"level":"warn","ts":"2026-10-16T11:34:12.867484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.141358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-16T11:34:12.86751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.569588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T11:34:12.86756Z","caller":"traceutil/trace.go:171","msg":"trace[1814950311] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:12197; }","duration":"151.645789ms","start":"2026-10-16T11:34:12.715901Z","end":"2026-10-16T11:34:12.867546Z","steps":["trace[1814950311] 'agreement among raft nodes before linearized reading' (duration: 151.531376ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:34:12.867562Z","caller":"traceutil/trace.go:171","msg":"trace[1525130352] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:12197; }","duration":"150.22502ms","start":"2026-10-16T11:34:12.717312Z","end":"2026-10-16T11:34:12.867537Z","steps":["trace[1525130352] 'agreement among raft nodes before linearized reading' (duration: 150.077776ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:34:12.867606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.176909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-16T11:34:12.867608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.350799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T11:34:12.867705Z","caller":"traceutil/trace.go:171","msg":"trace[1734637135] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:12197; }","duration":"152.508753ms","start":"2026-10-16T11:34:12.715169Z","end":"2026-10-16T11:34:12.867678Z","steps":["trace[1734637135] 'agreement among raft nodes before linearized reading' (duration: 152.277677ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:34:12.867705Z","caller":"traceutil/trace.go:171","msg":"trace[784043483] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:12197; }","duration":"150.281772ms","start":"2026-10-16T11:34:12.717399Z","end":"2026-10-16T11:34:12.867681Z","steps":["trace[784043483] 'agreement among raft nodes before linearized reading' (duration: 150.097267ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:34:12.867697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.095105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-16T11:34:12.867785Z","caller":"traceutil/trace.go:171","msg":"trace[1616589381] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:12197; }","duration":"142.224969ms","start":"2026-10-16T11:34:12.725537Z","end":"2026-10-16T11:34:12.867762Z","steps":["trace[1616589381] 'agreement among raft nodes before linearized reading' (duration: 142.021994ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:34:12.867946Z","caller":"traceutil/trace.go:171","msg":"trace[582015225] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:12197; }","duration":"147.258578ms","start":"2026-10-16T11:34:12.72025Z","end":"2026-10-16T11:34:12.867508Z","steps":["trace[582015225] 'agreement among raft nodes before linearized reading' (duration: 147.031622ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:35:15.946903Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10469} {"level":"info","ts":"2026-10-16T11:35:16.043256Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10469,"took":"93.989976ms","hash":1135772913,"current-db-size-bytes":57417728,"current-db-size":"57 MB","current-db-size-in-use-bytes":26578944,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-10-16T11:35:16.043323Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1135772913,"revision":10469,"compact-revision":8081} {"level":"warn","ts":"2026-10-16T11:40:01.016619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.122162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/placement-ks-endpoints\" ","response":"range_response_count:1 size:12751"} {"level":"info","ts":"2026-10-16T11:40:01.016707Z","caller":"traceutil/trace.go:171","msg":"trace[864862877] range","detail":"{range_begin:/registry/jobs/openstack/placement-ks-endpoints; range_end:; response_count:1; response_revision:14536; }","duration":"119.259765ms","start":"2026-10-16T11:40:00.89743Z","end":"2026-10-16T11:40:01.01669Z","steps":["trace[864862877] 'range keys from in-memory index tree' (duration: 118.965777ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:40:15.955962Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12636} {"level":"info","ts":"2026-10-16T11:40:16.04763Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12636,"took":"89.226883ms","hash":2310228939,"current-db-size-bytes":57417728,"current-db-size":"57 MB","current-db-size-in-use-bytes":27877376,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-16T11:40:16.047699Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2310228939,"revision":12636,"compact-revision":10469} {"level":"info","ts":"2026-10-16T11:40:23.455045Z","caller":"traceutil/trace.go:171","msg":"trace[231468396] transaction","detail":"{read_only:false; response_revision:14701; number_of_response:1; }","duration":"123.8933ms","start":"2026-10-16T11:40:23.331124Z","end":"2026-10-16T11:40:23.455018Z","steps":["trace[231468396] 'process raft request' (duration: 122.627865ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:40:23.456494Z","caller":"traceutil/trace.go:171","msg":"trace[517147658] transaction","detail":"{read_only:false; response_revision:14702; number_of_response:1; }","duration":"103.759344ms","start":"2026-10-16T11:40:23.35271Z","end":"2026-10-16T11:40:23.45647Z","steps":["trace[517147658] 'process raft request' (duration: 103.585639ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:40:45.034526Z","caller":"traceutil/trace.go:171","msg":"trace[256104775] transaction","detail":"{read_only:false; response_revision:14812; number_of_response:1; }","duration":"147.689257ms","start":"2026-10-16T11:40:44.886797Z","end":"2026-10-16T11:40:45.034486Z","steps":["trace[256104775] 'process raft request' (duration: 147.4645ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:41:02.865317Z","caller":"traceutil/trace.go:171","msg":"trace[212172351] linearizableReadLoop","detail":"{readStateIndex:15439; appliedIndex:15438; }","duration":"154.552166ms","start":"2026-10-16T11:41:02.710742Z","end":"2026-10-16T11:41:02.865294Z","steps":["trace[212172351] 'read index received' (duration: 154.34932ms)","trace[212172351] 'applied index is now lower than readState.Index' (duration: 201.706µs)"],"step_count":2} {"level":"warn","ts":"2026-10-16T11:41:02.865517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.771892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-16T11:41:02.86555Z","caller":"traceutil/trace.go:171","msg":"trace[1941458045] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14917; }","duration":"154.860184ms","start":"2026-10-16T11:41:02.710681Z","end":"2026-10-16T11:41:02.865542Z","steps":["trace[1941458045] 'agreement among raft nodes before linearized reading' (duration: 154.70524ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:41:02.865711Z","caller":"traceutil/trace.go:171","msg":"trace[488393627] transaction","detail":"{read_only:false; response_revision:14917; number_of_response:1; }","duration":"401.579894ms","start":"2026-10-16T11:41:02.464083Z","end":"2026-10-16T11:41:02.865663Z","steps":["trace[488393627] 'process raft request' (duration: 401.028859ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:41:02.865884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T11:41:02.464067Z","time spent":"401.725818ms","remote":"127.0.0.1:37872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12479,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T11:41:25.635705Z","caller":"traceutil/trace.go:171","msg":"trace[660551589] transaction","detail":"{read_only:false; response_revision:15230; number_of_response:1; }","duration":"293.495551ms","start":"2026-10-16T11:41:25.342187Z","end":"2026-10-16T11:41:25.635682Z","steps":["trace[660551589] 'process raft request' (duration: 293.324776ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:41:25.852549Z","caller":"traceutil/trace.go:171","msg":"trace[1031742303] linearizableReadLoop","detail":"{readStateIndex:15767; appliedIndex:15766; }","duration":"169.890959ms","start":"2026-10-16T11:41:25.682623Z","end":"2026-10-16T11:41:25.852514Z","steps":["trace[1031742303] 'read index received' (duration: 142.126053ms)","trace[1031742303] 'applied index is now lower than readState.Index' (duration: 27.763536ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T11:41:25.852699Z","caller":"traceutil/trace.go:171","msg":"trace[1693641320] transaction","detail":"{read_only:false; response_revision:15231; number_of_response:1; }","duration":"211.640931ms","start":"2026-10-16T11:41:25.641016Z","end":"2026-10-16T11:41:25.852657Z","steps":["trace[1693641320] 'process raft request' (duration: 183.649709ms)","trace[1693641320] 'compare' (duration: 27.734875ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T11:41:25.852816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.135776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-16T11:41:25.852921Z","caller":"traceutil/trace.go:171","msg":"trace[629126459] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:15231; }","duration":"170.331801ms","start":"2026-10-16T11:41:25.68257Z","end":"2026-10-16T11:41:25.852902Z","steps":["trace[629126459] 'agreement among raft nodes before linearized reading' (duration: 170.109405ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:41:25.865325Z","caller":"traceutil/trace.go:171","msg":"trace[735548469] transaction","detail":"{read_only:false; response_revision:15232; number_of_response:1; }","duration":"172.185142ms","start":"2026-10-16T11:41:25.693111Z","end":"2026-10-16T11:41:25.865296Z","steps":["trace[735548469] 'process raft request' (duration: 171.967306ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:41:25.865678Z","caller":"traceutil/trace.go:171","msg":"trace[1150722041] transaction","detail":"{read_only:false; response_revision:15233; number_of_response:1; }","duration":"135.696825ms","start":"2026-10-16T11:41:25.729921Z","end":"2026-10-16T11:41:25.865618Z","steps":["trace[1150722041] 'process raft request' (duration: 135.333065ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:41:25.86594Z","caller":"traceutil/trace.go:171","msg":"trace[98155547] transaction","detail":"{read_only:false; response_revision:15234; number_of_response:1; }","duration":"131.017257ms","start":"2026-10-16T11:41:25.734899Z","end":"2026-10-16T11:41:25.865916Z","steps":["trace[98155547] 'process raft request' (duration: 130.607795ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:41:25.86595Z","caller":"traceutil/trace.go:171","msg":"trace[1640455188] transaction","detail":"{read_only:false; response_revision:15235; number_of_response:1; }","duration":"130.493872ms","start":"2026-10-16T11:41:25.735441Z","end":"2026-10-16T11:41:25.865935Z","steps":["trace[1640455188] 'process raft request' (duration: 130.363368ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:41:26.009059Z","caller":"traceutil/trace.go:171","msg":"trace[1379774629] transaction","detail":"{read_only:false; response_revision:15236; number_of_response:1; }","duration":"135.214572ms","start":"2026-10-16T11:41:25.8738Z","end":"2026-10-16T11:41:26.009015Z","steps":["trace[1379774629] 'process raft request' (duration: 107.024504ms)","trace[1379774629] 'compare' (duration: 28.006213ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T11:42:52.211185Z","caller":"traceutil/trace.go:171","msg":"trace[854714611] linearizableReadLoop","detail":"{readStateIndex:16599; appliedIndex:16598; }","duration":"163.794541ms","start":"2026-10-16T11:42:52.047376Z","end":"2026-10-16T11:42:52.211171Z","steps":["trace[854714611] 'read index received' (duration: 163.75991ms)","trace[854714611] 'applied index is now lower than readState.Index' (duration: 33.651µs)"],"step_count":2} {"level":"info","ts":"2026-10-16T11:42:52.211272Z","caller":"traceutil/trace.go:171","msg":"trace[251779483] transaction","detail":"{read_only:false; response_revision:16041; number_of_response:1; }","duration":"195.783144ms","start":"2026-10-16T11:42:52.015438Z","end":"2026-10-16T11:42:52.211221Z","steps":["trace[251779483] 'process raft request' (duration: 195.624479ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:42:52.211494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.103009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"} {"level":"info","ts":"2026-10-16T11:42:52.214892Z","caller":"traceutil/trace.go:171","msg":"trace[2081965592] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16041; }","duration":"167.556664ms","start":"2026-10-16T11:42:52.047312Z","end":"2026-10-16T11:42:52.214869Z","steps":["trace[2081965592] 'agreement among raft nodes before linearized reading' (duration: 163.971265ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:42:52.220542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.127086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-vp5br\" ","response":"range_response_count:1 size:22096"} {"level":"warn","ts":"2026-10-16T11:42:52.220585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.771497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-10-16T11:42:52.220617Z","caller":"traceutil/trace.go:171","msg":"trace[555142468] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-vp5br; range_end:; response_count:1; response_revision:16043; }","duration":"128.240649ms","start":"2026-10-16T11:42:52.092359Z","end":"2026-10-16T11:42:52.220599Z","steps":["trace[555142468] 'agreement among raft nodes before linearized reading' (duration: 128.058064ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:42:52.220644Z","caller":"traceutil/trace.go:171","msg":"trace[619118827] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16043; }","duration":"164.84307ms","start":"2026-10-16T11:42:52.055779Z","end":"2026-10-16T11:42:52.220622Z","steps":["trace[619118827] 'agreement among raft nodes before linearized reading' (duration: 164.714706ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:42:52.220725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.959383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T11:42:52.2208Z","caller":"traceutil/trace.go:171","msg":"trace[1613524642] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16043; }","duration":"173.117048ms","start":"2026-10-16T11:42:52.047665Z","end":"2026-10-16T11:42:52.220782Z","steps":["trace[1613524642] 'agreement among raft nodes before linearized reading' (duration: 172.568733ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:44:11.659112Z","caller":"traceutil/trace.go:171","msg":"trace[1558426751] transaction","detail":"{read_only:false; response_revision:16555; number_of_response:1; }","duration":"125.065302ms","start":"2026-10-16T11:44:11.534014Z","end":"2026-10-16T11:44:11.659079Z","steps":["trace[1558426751] 'process raft request' (duration: 124.886337ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:44:13.109931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.171842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-10-16T11:44:13.109997Z","caller":"traceutil/trace.go:171","msg":"trace[1010261556] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:16562; }","duration":"118.268835ms","start":"2026-10-16T11:44:12.99171Z","end":"2026-10-16T11:44:13.109979Z","steps":["trace[1010261556] 'range keys from in-memory index tree' (duration: 118.032578ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:44:13.110338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.316384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-16T11:44:13.110397Z","caller":"traceutil/trace.go:171","msg":"trace[2005332097] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:16562; }","duration":"110.387297ms","start":"2026-10-16T11:44:12.999975Z","end":"2026-10-16T11:44:13.110362Z","steps":["trace[2005332097] 'range keys from in-memory index tree' (duration: 110.272703ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:44:47.010454Z","caller":"traceutil/trace.go:171","msg":"trace[134652029] transaction","detail":"{read_only:false; response_revision:16765; number_of_response:1; }","duration":"137.632605ms","start":"2026-10-16T11:44:46.872786Z","end":"2026-10-16T11:44:47.010419Z","steps":["trace[134652029] 'process raft request' (duration: 137.380708ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:45:15.965119Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14657} {"level":"info","ts":"2026-10-16T11:45:16.044492Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14657,"took":"77.337153ms","hash":3827205294,"current-db-size-bytes":57417728,"current-db-size":"57 MB","current-db-size-in-use-bytes":31051776,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-16T11:45:16.044648Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3827205294,"revision":14657,"compact-revision":12636} {"level":"info","ts":"2026-10-16T11:45:17.45586Z","caller":"traceutil/trace.go:171","msg":"trace[226279859] transaction","detail":"{read_only:false; response_revision:17026; number_of_response:1; }","duration":"104.109431ms","start":"2026-10-16T11:45:17.351717Z","end":"2026-10-16T11:45:17.455827Z","steps":["trace[226279859] 'process raft request' (duration: 54.557635ms)","trace[226279859] 'compare' (duration: 49.438513ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T11:49:20.342333Z","caller":"traceutil/trace.go:171","msg":"trace[1098905509] transaction","detail":"{read_only:false; response_revision:18841; number_of_response:1; }","duration":"242.414393ms","start":"2026-10-16T11:49:20.099889Z","end":"2026-10-16T11:49:20.342303Z","steps":["trace[1098905509] 'process raft request' (duration: 242.162766ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:49:20.363009Z","caller":"traceutil/trace.go:171","msg":"trace[1150633536] transaction","detail":"{read_only:false; response_revision:18842; number_of_response:1; }","duration":"130.006693ms","start":"2026-10-16T11:49:20.232974Z","end":"2026-10-16T11:49:20.362981Z","steps":["trace[1150633536] 'process raft request' (duration: 129.781757ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:49:21.03514Z","caller":"traceutil/trace.go:171","msg":"trace[514531520] linearizableReadLoop","detail":"{readStateIndex:19496; appliedIndex:19495; }","duration":"285.822586ms","start":"2026-10-16T11:49:20.749285Z","end":"2026-10-16T11:49:21.035107Z","steps":["trace[514531520] 'read index received' (duration: 266.235097ms)","trace[514531520] 'applied index is now lower than readState.Index' (duration: 19.586209ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T11:49:21.035355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.054732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-10-16T11:49:21.035393Z","caller":"traceutil/trace.go:171","msg":"trace[1625088981] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18845; }","duration":"286.159845ms","start":"2026-10-16T11:49:20.749222Z","end":"2026-10-16T11:49:21.035382Z","steps":["trace[1625088981] 'agreement among raft nodes before linearized reading' (duration: 285.981931ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:49:21.035749Z","caller":"traceutil/trace.go:171","msg":"trace[1760848203] transaction","detail":"{read_only:false; response_revision:18845; number_of_response:1; }","duration":"286.812633ms","start":"2026-10-16T11:49:20.748899Z","end":"2026-10-16T11:49:21.035711Z","steps":["trace[1760848203] 'process raft request' (duration: 266.488275ms)","trace[1760848203] 'compare' (duration: 19.474425ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T11:49:21.276843Z","caller":"traceutil/trace.go:171","msg":"trace[1229331172] transaction","detail":"{read_only:false; response_revision:18847; number_of_response:1; }","duration":"229.965861ms","start":"2026-10-16T11:49:21.046838Z","end":"2026-10-16T11:49:21.276804Z","steps":["trace[1229331172] 'process raft request' (duration: 214.335961ms)","trace[1229331172] 'compare' (duration: 15.342332ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T11:49:21.2928Z","caller":"traceutil/trace.go:171","msg":"trace[1725246136] linearizableReadLoop","detail":"{readStateIndex:19499; appliedIndex:19497; }","duration":"236.215192ms","start":"2026-10-16T11:49:21.056566Z","end":"2026-10-16T11:49:21.292781Z","steps":["trace[1725246136] 'read index received' (duration: 204.526331ms)","trace[1725246136] 'applied index is now lower than readState.Index' (duration: 31.687931ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T11:49:21.292894Z","caller":"traceutil/trace.go:171","msg":"trace[1555316874] transaction","detail":"{read_only:false; response_revision:18848; number_of_response:1; }","duration":"245.95366ms","start":"2026-10-16T11:49:21.046931Z","end":"2026-10-16T11:49:21.292884Z","steps":["trace[1555316874] 'process raft request' (duration: 245.746844ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:49:21.293162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.577043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-10-16T11:49:21.293219Z","caller":"traceutil/trace.go:171","msg":"trace[313272349] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18848; }","duration":"236.700746ms","start":"2026-10-16T11:49:21.056503Z","end":"2026-10-16T11:49:21.293203Z","steps":["trace[313272349] 'agreement among raft nodes before linearized reading' (duration: 236.516911ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:49:21.293309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.90478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-10-16T11:49:21.293455Z","caller":"traceutil/trace.go:171","msg":"trace[812516564] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:18848; }","duration":"170.229549ms","start":"2026-10-16T11:49:21.123195Z","end":"2026-10-16T11:49:21.293425Z","steps":["trace[812516564] 'agreement among raft nodes before linearized reading' (duration: 169.803857ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:49:56.234754Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"cb89ec34a9687f0b","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-16T11:49:56.241992Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-16T11:49:56.242216Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-10-16T11:50:15.972135Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17006} {"level":"info","ts":"2026-10-16T11:50:16.084545Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17006,"took":"107.907156ms","hash":100015033,"current-db-size-bytes":57417728,"current-db-size":"57 MB","current-db-size-in-use-bytes":33234944,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-16T11:50:16.084635Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":100015033,"revision":17006,"compact-revision":14657} {"level":"info","ts":"2026-10-16T11:55:15.984643Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19504} {"level":"info","ts":"2026-10-16T11:55:16.11051Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19504,"took":"120.453241ms","hash":3329103774,"current-db-size-bytes":57417728,"current-db-size":"57 MB","current-db-size-in-use-bytes":29949952,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-16T11:55:16.110587Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3329103774,"revision":19504,"compact-revision":17006} {"level":"warn","ts":"2026-10-16T11:55:35.72808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.426591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"warn","ts":"2026-10-16T11:55:35.728111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.61628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"info","ts":"2026-10-16T11:55:35.72817Z","caller":"traceutil/trace.go:171","msg":"trace[1995326228] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21705; }","duration":"108.556825ms","start":"2026-10-16T11:55:35.619586Z","end":"2026-10-16T11:55:35.728143Z","steps":["trace[1995326228] 'range keys from in-memory index tree' (duration: 108.246806ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:55:35.728188Z","caller":"traceutil/trace.go:171","msg":"trace[1385029070] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:21705; }","duration":"207.745823ms","start":"2026-10-16T11:55:35.520423Z","end":"2026-10-16T11:55:35.728168Z","steps":["trace[1385029070] 'range keys from in-memory index tree' (duration: 207.462425ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:55:36.143564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.560905ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-16T11:55:36.143809Z","caller":"traceutil/trace.go:171","msg":"trace[1928142122] linearizableReadLoop","detail":"{readStateIndex:22457; appliedIndex:22456; }","duration":"296.850786ms","start":"2026-10-16T11:55:35.846932Z","end":"2026-10-16T11:55:36.143782Z","steps":["trace[1928142122] 'read index received' (duration: 107.069705ms)","trace[1928142122] 'applied index is now lower than readState.Index' (duration: 189.779171ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T11:55:36.143804Z","caller":"traceutil/trace.go:171","msg":"trace[1422391370] transaction","detail":"{read_only:false; response_revision:21707; number_of_response:1; }","duration":"324.128993ms","start":"2026-10-16T11:55:35.819599Z","end":"2026-10-16T11:55:36.143728Z","steps":["trace[1422391370] 'process raft request' (duration: 134.285541ms)","trace[1422391370] 'compare' (duration: 189.336758ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T11:55:36.143959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.01222ms","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:6"} {"level":"info","ts":"2026-10-16T11:55:36.144079Z","caller":"traceutil/trace.go:171","msg":"trace[271933968] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:21707; }","duration":"297.164584ms","start":"2026-10-16T11:55:35.846893Z","end":"2026-10-16T11:55:36.144057Z","steps":["trace[271933968] 'agreement among raft nodes before linearized reading' (duration: 296.948198ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:55:36.144087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T11:55:35.819574Z","time spent":"324.350289ms","remote":"127.0.0.1:37944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T11:55:36.168478Z","caller":"traceutil/trace.go:171","msg":"trace[2091541653] transaction","detail":"{read_only:false; response_revision:21709; number_of_response:1; }","duration":"262.606797ms","start":"2026-10-16T11:55:35.905848Z","end":"2026-10-16T11:55:36.168455Z","steps":["trace[2091541653] 'process raft request' (duration: 262.533505ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:55:36.168686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.149842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-16T11:55:36.168775Z","caller":"traceutil/trace.go:171","msg":"trace[731980758] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21709; }","duration":"313.270195ms","start":"2026-10-16T11:55:35.855491Z","end":"2026-10-16T11:55:36.168762Z","steps":["trace[731980758] 'agreement among raft nodes before linearized reading' (duration: 312.929776ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:55:36.168819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.927732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-16T11:55:36.168885Z","caller":"traceutil/trace.go:171","msg":"trace[2132838587] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:21709; }","duration":"295.041865ms","start":"2026-10-16T11:55:35.873829Z","end":"2026-10-16T11:55:36.168871Z","steps":["trace[2132838587] 'agreement among raft nodes before linearized reading' (duration: 294.928272ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:55:36.168945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T11:55:35.855477Z","time spent":"313.378689ms","remote":"127.0.0.1:37944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-10-16T11:55:36.168672Z","caller":"traceutil/trace.go:171","msg":"trace[1012333651] transaction","detail":"{read_only:false; response_revision:21708; number_of_response:1; }","duration":"264.458748ms","start":"2026-10-16T11:55:35.904182Z","end":"2026-10-16T11:55:36.16864Z","steps":["trace[1012333651] 'process raft request' (duration: 264.092498ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:55:36.169195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.498959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-10-16T11:55:36.169267Z","caller":"traceutil/trace.go:171","msg":"trace[1664592560] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:21709; }","duration":"306.640593ms","start":"2026-10-16T11:55:35.862606Z","end":"2026-10-16T11:55:36.169247Z","steps":["trace[1664592560] 'agreement among raft nodes before linearized reading' (duration: 306.370186ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:55:36.169403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T11:55:35.862596Z","time spent":"306.792457ms","remote":"127.0.0.1:37944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-16T11:55:36.406338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.53099ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-16T11:55:36.406436Z","caller":"traceutil/trace.go:171","msg":"trace[728157277] linearizableReadLoop","detail":"{readStateIndex:22461; appliedIndex:22459; }","duration":"231.557696ms","start":"2026-10-16T11:55:36.174862Z","end":"2026-10-16T11:55:36.406419Z","steps":["trace[728157277] 'read index received' (duration: 67.11597ms)","trace[728157277] 'applied index is now lower than readState.Index' (duration: 164.440396ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T11:55:36.406514Z","caller":"traceutil/trace.go:171","msg":"trace[723027976] transaction","detail":"{read_only:false; response_revision:21711; number_of_response:1; }","duration":"232.44664ms","start":"2026-10-16T11:55:36.174034Z","end":"2026-10-16T11:55:36.40648Z","steps":["trace[723027976] 'process raft request' (duration: 75.662103ms)","trace[723027976] 'compare' (duration: 155.846151ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T11:55:36.406565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.564575ms","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:6"} {"level":"info","ts":"2026-10-16T11:55:36.406594Z","caller":"traceutil/trace.go:171","msg":"trace[1901129763] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:21711; }","duration":"139.630737ms","start":"2026-10-16T11:55:36.266952Z","end":"2026-10-16T11:55:36.406583Z","steps":["trace[1901129763] 'agreement among raft nodes before linearized reading' (duration: 139.569295ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T11:55:36.406713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.828193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12429"} {"level":"info","ts":"2026-10-16T11:55:36.407051Z","caller":"traceutil/trace.go:171","msg":"trace[1084555415] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:21711; }","duration":"232.195383ms","start":"2026-10-16T11:55:36.174837Z","end":"2026-10-16T11:55:36.407033Z","steps":["trace[1084555415] 'agreement among raft nodes before linearized reading' (duration: 231.637388ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T11:56:49.891152Z","caller":"traceutil/trace.go:171","msg":"trace[1504107888] transaction","detail":"{read_only:false; response_revision:22382; number_of_response:1; }","duration":"103.165307ms","start":"2026-10-16T11:56:49.787956Z","end":"2026-10-16T11:56:49.891121Z","steps":["trace[1504107888] 'process raft request' (duration: 59.421798ms)","trace[1504107888] 'compare' (duration: 43.607685ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T11:59:45.334503Z","caller":"traceutil/trace.go:171","msg":"trace[1771602350] transaction","detail":"{read_only:false; response_revision:24234; number_of_response:1; }","duration":"128.639806ms","start":"2026-10-16T11:59:45.205827Z","end":"2026-10-16T11:59:45.334467Z","steps":["trace[1771602350] 'process raft request' (duration: 121.908062ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T12:00:15.989027Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21609} {"level":"info","ts":"2026-10-16T12:00:16.107262Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21609,"took":"114.631332ms","hash":3250182713,"current-db-size-bytes":57417728,"current-db-size":"57 MB","current-db-size-in-use-bytes":42692608,"current-db-size-in-use":"43 MB"} {"level":"info","ts":"2026-10-16T12:00:16.107341Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3250182713,"revision":21609,"compact-revision":19504} {"level":"info","ts":"2026-10-16T12:01:05.557368Z","caller":"traceutil/trace.go:171","msg":"trace[654350479] transaction","detail":"{read_only:false; response_revision:25232; number_of_response:1; }","duration":"108.789112ms","start":"2026-10-16T12:01:05.448546Z","end":"2026-10-16T12:01:05.557335Z","steps":["trace[654350479] 'process raft request' (duration: 108.581706ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T12:01:23.290672Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006695.wal"} {"level":"info","ts":"2026-10-16T12:03:14.775996Z","caller":"traceutil/trace.go:171","msg":"trace[203686227] linearizableReadLoop","detail":"{readStateIndex:27261; appliedIndex:27260; }","duration":"328.101862ms","start":"2026-10-16T12:03:14.44786Z","end":"2026-10-16T12:03:14.775962Z","steps":["trace[203686227] 'read index received' (duration: 327.963848ms)","trace[203686227] 'applied index is now lower than readState.Index' (duration: 137.144µs)"],"step_count":2} {"level":"info","ts":"2026-10-16T12:03:14.776019Z","caller":"traceutil/trace.go:171","msg":"trace[1919049114] transaction","detail":"{read_only:false; response_revision:26389; number_of_response:1; }","duration":"344.196073ms","start":"2026-10-16T12:03:14.4318Z","end":"2026-10-16T12:03:14.775996Z","steps":["trace[1919049114] 'process raft request' (duration: 344.033079ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T12:03:14.77615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T12:03:14.431775Z","time spent":"344.302446ms","remote":"127.0.0.1:37944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T12:03:14.77618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.310068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-10-16T12:03:14.776213Z","caller":"traceutil/trace.go:171","msg":"trace[231585949] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26389; }","duration":"328.38335ms","start":"2026-10-16T12:03:14.447817Z","end":"2026-10-16T12:03:14.7762Z","steps":["trace[231585949] 'agreement among raft nodes before linearized reading' (duration: 328.270477ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T12:03:14.77626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T12:03:14.447798Z","time spent":"328.454552ms","remote":"127.0.0.1:37944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":519,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-10-16T12:03:14.809445Z","caller":"traceutil/trace.go:171","msg":"trace[1600254576] transaction","detail":"{read_only:false; response_revision:26390; number_of_response:1; }","duration":"218.94235ms","start":"2026-10-16T12:03:14.590477Z","end":"2026-10-16T12:03:14.80942Z","steps":["trace[1600254576] 'process raft request' (duration: 218.738425ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T12:03:14.809655Z","caller":"traceutil/trace.go:171","msg":"trace[157456291] transaction","detail":"{read_only:false; response_revision:26391; number_of_response:1; }","duration":"179.182981ms","start":"2026-10-16T12:03:14.630463Z","end":"2026-10-16T12:03:14.809646Z","steps":["trace[157456291] 'process raft request' (duration: 178.913434ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T12:03:14.994327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.431424ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:30"} {"level":"info","ts":"2026-10-16T12:03:14.994669Z","caller":"traceutil/trace.go:171","msg":"trace[1601358132] transaction","detail":"{read_only:false; response_revision:26393; number_of_response:1; }","duration":"210.796297ms","start":"2026-10-16T12:03:14.783838Z","end":"2026-10-16T12:03:14.994635Z","steps":["trace[1601358132] 'process raft request' (duration: 210.587842ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T12:03:14.994639Z","caller":"traceutil/trace.go:171","msg":"trace[710831921] linearizableReadLoop","detail":"{readStateIndex:27265; appliedIndex:27261; }","duration":"218.522609ms","start":"2026-10-16T12:03:14.776063Z","end":"2026-10-16T12:03:14.994585Z","steps":["trace[710831921] 'read index received' (duration: 33.149698ms)","trace[710831921] 'applied index is now lower than readState.Index' (duration: 185.369771ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T12:03:15.208412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.516992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-10-16T12:03:15.208511Z","caller":"traceutil/trace.go:171","msg":"trace[1525547978] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26393; }","duration":"371.670726ms","start":"2026-10-16T12:03:14.836812Z","end":"2026-10-16T12:03:15.208482Z","steps":["trace[1525547978] 'agreement among raft nodes before linearized reading' (duration: 158.210446ms)","trace[1525547978] 'range keys from in-memory index tree' (duration: 213.185873ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T12:03:15.208555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T12:03:14.83679Z","time spent":"371.755229ms","remote":"127.0.0.1:37944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-16T12:03:15.208557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.888119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-16T12:03:15.208673Z","caller":"traceutil/trace.go:171","msg":"trace[887541367] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26393; }","duration":"435.043343ms","start":"2026-10-16T12:03:14.773601Z","end":"2026-10-16T12:03:15.208644Z","steps":["trace[887541367] 'agreement among raft nodes before linearized reading' (duration: 221.1158ms)","trace[887541367] 'range keys from in-memory index tree' (duration: 213.539102ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T12:03:15.208734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T12:03:14.773584Z","time spent":"435.136036ms","remote":"127.0.0.1:37944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-16T12:03:15.208837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.565604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-16T12:03:15.20897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.91875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-16T12:03:15.209045Z","caller":"traceutil/trace.go:171","msg":"trace[892639224] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:26393; }","duration":"250.438354ms","start":"2026-10-16T12:03:14.95858Z","end":"2026-10-16T12:03:15.209018Z","steps":["trace[892639224] 'agreement among raft nodes before linearized reading' (duration: 36.434129ms)","trace[892639224] 'count revisions from in-memory index tree' (duration: 213.500171ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T12:03:15.209124Z","caller":"traceutil/trace.go:171","msg":"trace[890800594] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26393; }","duration":"421.79273ms","start":"2026-10-16T12:03:14.787201Z","end":"2026-10-16T12:03:15.208993Z","steps":["trace[890800594] 'agreement among raft nodes before linearized reading' (duration: 207.805446ms)","trace[890800594] 'range keys from in-memory index tree' (duration: 213.667296ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T12:03:15.209267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T12:03:14.787179Z","time spent":"422.040866ms","remote":"127.0.0.1:37704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-16T12:03:15.274322Z","caller":"traceutil/trace.go:171","msg":"trace[637284423] transaction","detail":"{read_only:false; response_revision:26394; number_of_response:1; }","duration":"166.045121ms","start":"2026-10-16T12:03:15.108235Z","end":"2026-10-16T12:03:15.27428Z","steps":["trace[637284423] 'process raft request' (duration: 165.770144ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T12:03:19.998621Z","caller":"traceutil/trace.go:171","msg":"trace[226784559] transaction","detail":"{read_only:false; response_revision:26435; number_of_response:1; }","duration":"126.943659ms","start":"2026-10-16T12:03:19.871655Z","end":"2026-10-16T12:03:19.998598Z","steps":["trace[226784559] 'process raft request' (duration: 126.817636ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T12:04:13.282361Z","caller":"traceutil/trace.go:171","msg":"trace[1082663176] linearizableReadLoop","detail":"{readStateIndex:27813; appliedIndex:27812; }","duration":"105.064079ms","start":"2026-10-16T12:04:13.17728Z","end":"2026-10-16T12:04:13.282344Z","steps":["trace[1082663176] 'read index received' (duration: 104.884174ms)","trace[1082663176] 'applied index is now lower than readState.Index' (duration: 179.085µs)"],"step_count":2} {"level":"info","ts":"2026-10-16T12:04:13.282452Z","caller":"traceutil/trace.go:171","msg":"trace[1808290254] transaction","detail":"{read_only:false; response_revision:26928; number_of_response:1; }","duration":"111.754063ms","start":"2026-10-16T12:04:13.170691Z","end":"2026-10-16T12:04:13.282445Z","steps":["trace[1808290254] 'process raft request' (duration: 111.497836ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T12:04:13.282613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.318366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-16T12:04:13.282664Z","caller":"traceutil/trace.go:171","msg":"trace[1585205388] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:26928; }","duration":"105.407848ms","start":"2026-10-16T12:04:13.177245Z","end":"2026-10-16T12:04:13.282653Z","steps":["trace[1585205388] 'agreement among raft nodes before linearized reading' (duration: 105.339937ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T12:04:19.249785Z","caller":"traceutil/trace.go:171","msg":"trace[417919704] transaction","detail":"{read_only:false; response_revision:26969; number_of_response:1; }","duration":"223.29323ms","start":"2026-10-16T12:04:19.026462Z","end":"2026-10-16T12:04:19.249755Z","steps":["trace[417919704] 'process raft request' (duration: 223.104845ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T12:04:19.2618Z","caller":"traceutil/trace.go:171","msg":"trace[1538693068] transaction","detail":"{read_only:false; response_revision:26971; number_of_response:1; }","duration":"218.428026ms","start":"2026-10-16T12:04:19.043353Z","end":"2026-10-16T12:04:19.261781Z","steps":["trace[1538693068] 'process raft request' (duration: 218.396015ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T12:04:19.262152Z","caller":"traceutil/trace.go:171","msg":"trace[1608770898] transaction","detail":"{read_only:false; response_revision:26970; number_of_response:1; }","duration":"235.294238ms","start":"2026-10-16T12:04:19.026848Z","end":"2026-10-16T12:04:19.262142Z","steps":["trace[1608770898] 'process raft request' (duration: 234.757833ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T12:04:19.466041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.99312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.36\" ","response":"range_response_count:1 size:137"} {"level":"warn","ts":"2026-10-16T12:04:19.466046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.576009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-10-16T12:04:19.466151Z","caller":"traceutil/trace.go:171","msg":"trace[1476525602] range","detail":"{range_begin:/registry/masterleases/162.253.55.36; range_end:; response_count:1; response_revision:26971; }","duration":"108.143464ms","start":"2026-10-16T12:04:19.357986Z","end":"2026-10-16T12:04:19.46613Z","steps":["trace[1476525602] 'range keys from in-memory index tree' (duration: 107.776464ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T12:04:19.466173Z","caller":"traceutil/trace.go:171","msg":"trace[13488091] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26971; }","duration":"126.728924ms","start":"2026-10-16T12:04:19.339424Z","end":"2026-10-16T12:04:19.466153Z","steps":["trace[13488091] 'range keys from in-memory index tree' (duration: 126.414735ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T12:05:15.99513Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24680} {"level":"info","ts":"2026-10-16T12:05:16.14133Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24680,"took":"141.59161ms","hash":3107759100,"current-db-size-bytes":59527168,"current-db-size":"60 MB","current-db-size-in-use-bytes":36794368,"current-db-size-in-use":"37 MB"} {"level":"info","ts":"2026-10-16T12:05:16.141397Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3107759100,"revision":24680,"compact-revision":21609} {"level":"info","ts":"2026-10-16T12:07:46.833513Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"cb89ec34a9687f0b","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-16T12:07:46.837821Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-10-16T12:07:46.837928Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-10-16T12:08:35.806884Z","caller":"traceutil/trace.go:171","msg":"trace[1407539819] transaction","detail":"{read_only:false; response_revision:29544; number_of_response:1; }","duration":"124.116377ms","start":"2026-10-16T12:08:35.682735Z","end":"2026-10-16T12:08:35.806852Z","steps":["trace[1407539819] 'process raft request' (duration: 103.232409ms)","trace[1407539819] 'compare' (duration: 16.696304ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T12:10:16.011687Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27638} {"level":"info","ts":"2026-10-16T12:10:16.161755Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27638,"took":"146.232809ms","hash":2687952591,"current-db-size-bytes":59527168,"current-db-size":"60 MB","current-db-size-in-use-bytes":35524608,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-10-16T12:10:16.161842Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2687952591,"revision":27638,"compact-revision":24680} {"level":"info","ts":"2026-10-16T12:15:16.043563Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30339} {"level":"info","ts":"2026-10-16T12:15:16.243019Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30339,"took":"195.130009ms","hash":1447923729,"current-db-size-bytes":59527168,"current-db-size":"60 MB","current-db-size-in-use-bytes":31481856,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-16T12:15:16.243089Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1447923729,"revision":30339,"compact-revision":27638} {"level":"info","ts":"2026-10-16T12:20:16.050702Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32594} {"level":"info","ts":"2026-10-16T12:20:16.214067Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32594,"took":"157.881548ms","hash":2615555274,"current-db-size-bytes":60571648,"current-db-size":"61 MB","current-db-size-in-use-bytes":30646272,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-16T12:20:16.214185Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2615555274,"revision":32594,"compact-revision":30339} {"level":"info","ts":"2026-10-16T12:25:16.058254Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34826} {"level":"info","ts":"2026-10-16T12:25:16.191916Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34826,"took":"126.950781ms","hash":4275222912,"current-db-size-bytes":60571648,"current-db-size":"61 MB","current-db-size-in-use-bytes":31580160,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-16T12:25:16.191994Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4275222912,"revision":34826,"compact-revision":32594} {"level":"info","ts":"2026-10-16T12:28:58.885152Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"cb89ec34a9687f0b","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-16T12:28:58.890961Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-10-16T12:28:58.891059Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-10-16T12:30:16.06749Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37118} {"level":"info","ts":"2026-10-16T12:30:16.189794Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37118,"took":"118.975653ms","hash":3137293340,"current-db-size-bytes":61419520,"current-db-size":"61 MB","current-db-size-in-use-bytes":33280000,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-16T12:30:16.189863Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3137293340,"revision":37118,"compact-revision":34826} {"level":"info","ts":"2026-10-16T12:35:16.075575Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39395} {"level":"info","ts":"2026-10-16T12:35:16.213519Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39395,"took":"134.368443ms","hash":2435066197,"current-db-size-bytes":62267392,"current-db-size":"62 MB","current-db-size-in-use-bytes":31555584,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-16T12:35:16.213583Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2435066197,"revision":39395,"compact-revision":37118}