{"level":"warn","ts":"2026-07-30T04:57:48.317796Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-30T04:57:48.31791Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.23:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.23:2380","--initial-cluster=instance=https://199.204.45.23:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.23:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.23:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-07-30T04:57:48.318001Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-30T04:57:48.318015Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.23:2380"]} {"level":"info","ts":"2026-07-30T04:57:48.318037Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-30T04:57:48.318738Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"]} {"level":"info","ts":"2026-07-30T04:57:48.318828Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.23:2380"],"listen-peer-urls":["https://199.204.45.23:2380"],"advertise-client-urls":["https://199.204.45.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.23:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-07-30T04:57:48.321654Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.57346ms"} {"level":"info","ts":"2026-07-30T04:57:48.325446Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"51a5c416a4d98c86","cluster-id":"ade2045974c19907"} {"level":"info","ts":"2026-07-30T04:57:48.325535Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=()"} {"level":"info","ts":"2026-07-30T04:57:48.325562Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became follower at term 0"} {"level":"info","ts":"2026-07-30T04:57:48.325579Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 51a5c416a4d98c86 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-30T04:57:48.325619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became follower at term 1"} {"level":"info","ts":"2026-07-30T04:57:48.325704Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=(5883324089763466374)"} {"level":"warn","ts":"2026-07-30T04:57:48.33086Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-30T04:57:48.332175Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-30T04:57:48.33347Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-07-30T04:57:48.335797Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"51a5c416a4d98c86","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-30T04:57:48.335982Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"51a5c416a4d98c86","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-30T04:57:48.336015Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-30T04:57:48.336172Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-30T04:57:48.336186Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-30T04:57:48.339007Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=(5883324089763466374)"} {"level":"info","ts":"2026-07-30T04:57:48.339411Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ade2045974c19907","local-member-id":"51a5c416a4d98c86","added-peer-id":"51a5c416a4d98c86","added-peer-peer-urls":["https://199.204.45.23:2380"]} {"level":"info","ts":"2026-07-30T04:57:48.341195Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-30T04:57:48.341304Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.23:2380"} {"level":"info","ts":"2026-07-30T04:57:48.341361Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.23:2380"} {"level":"info","ts":"2026-07-30T04:57:48.34183Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"51a5c416a4d98c86","initial-advertise-peer-urls":["https://199.204.45.23:2380"],"listen-peer-urls":["https://199.204.45.23:2380"],"advertise-client-urls":["https://199.204.45.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-30T04:57:48.341912Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-30T04:57:48.626672Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 is starting a new election at term 1"} {"level":"info","ts":"2026-07-30T04:57:48.626748Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-30T04:57:48.626774Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 received MsgPreVoteResp from 51a5c416a4d98c86 at term 1"} {"level":"info","ts":"2026-07-30T04:57:48.626796Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became candidate at term 2"} {"level":"info","ts":"2026-07-30T04:57:48.62681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 received MsgVoteResp from 51a5c416a4d98c86 at term 2"} {"level":"info","ts":"2026-07-30T04:57:48.626846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became leader at term 2"} {"level":"info","ts":"2026-07-30T04:57:48.626865Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 51a5c416a4d98c86 elected leader 51a5c416a4d98c86 at term 2"} {"level":"info","ts":"2026-07-30T04:57:48.627808Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-30T04:57:48.628467Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"51a5c416a4d98c86","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.23:2379]}","request-path":"/0/members/51a5c416a4d98c86/attributes","cluster-id":"ade2045974c19907","publish-timeout":"7s"} {"level":"info","ts":"2026-07-30T04:57:48.628467Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-30T04:57:48.628545Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-30T04:57:48.628874Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-30T04:57:48.628942Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-30T04:57:48.62909Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ade2045974c19907","local-member-id":"51a5c416a4d98c86","cluster-version":"3.5"} {"level":"info","ts":"2026-07-30T04:57:48.62923Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-30T04:57:48.629273Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-30T04:57:48.6324Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-30T04:57:48.632503Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.23:2379"} {"level":"info","ts":"2026-07-30T04:58:31.357412Z","caller":"traceutil/trace.go:171","msg":"trace[1754728825] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"177.627014ms","start":"2026-07-30T04:58:31.179724Z","end":"2026-07-30T04:58:31.357351Z","steps":["trace[1754728825] 'process raft request' (duration: 175.720938ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T04:58:31.801365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.079288ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-30T04:58:31.801521Z","caller":"traceutil/trace.go:171","msg":"trace[169792294] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:613; }","duration":"329.459684ms","start":"2026-07-30T04:58:31.472046Z","end":"2026-07-30T04:58:31.801506Z","steps":["trace[169792294] 'read index received' (duration: 26.742035ms)","trace[169792294] 'applied index is now lower than readState.Index' (duration: 302.716699ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T04:58:31.801734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.687258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-30T04:58:31.801763Z","caller":"traceutil/trace.go:171","msg":"trace[83781330] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:590; }","duration":"329.766ms","start":"2026-07-30T04:58:31.47199Z","end":"2026-07-30T04:58:31.801756Z","steps":["trace[83781330] 'agreement among raft nodes before linearized reading' (duration: 329.583206ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T04:58:31.801789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T04:58:31.471968Z","time spent":"329.815431ms","remote":"127.0.0.1:36804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-30T04:58:31.801563Z","caller":"traceutil/trace.go:171","msg":"trace[480601487] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"381.395323ms","start":"2026-07-30T04:58:31.420131Z","end":"2026-07-30T04:58:31.801527Z","steps":["trace[480601487] 'process raft request' (duration: 78.741704ms)","trace[480601487] 'compare' (duration: 301.935235ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T04:58:31.801999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T04:58:31.420102Z","time spent":"381.777189ms","remote":"127.0.0.1:36882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-30T04:58:31.801996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.129974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-cgbdg\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-07-30T04:58:31.802122Z","caller":"traceutil/trace.go:171","msg":"trace[486971716] range","detail":"{range_begin:/registry/pods/kube-system/cilium-cgbdg; range_end:; response_count:1; response_revision:590; }","duration":"178.315567ms","start":"2026-07-30T04:58:31.623776Z","end":"2026-07-30T04:58:31.802092Z","steps":["trace[486971716] 'agreement among raft nodes before linearized reading' (duration: 177.91554ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T04:58:47.157726Z","caller":"traceutil/trace.go:171","msg":"trace[121614734] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"100.507462ms","start":"2026-07-30T04:58:47.057182Z","end":"2026-07-30T04:58:47.15769Z","steps":["trace[121614734] 'process raft request' (duration: 100.192106ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T04:59:51.064544Z","caller":"traceutil/trace.go:171","msg":"trace[1627980627] transaction","detail":"{read_only:false; response_revision:1323; number_of_response:1; }","duration":"212.851271ms","start":"2026-07-30T04:59:50.851664Z","end":"2026-07-30T04:59:51.064515Z","steps":["trace[1627980627] 'process raft request' (duration: 212.689278ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T04:59:51.094445Z","caller":"traceutil/trace.go:171","msg":"trace[915345239] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"240.641448ms","start":"2026-07-30T04:59:50.853767Z","end":"2026-07-30T04:59:51.094408Z","steps":["trace[915345239] 'process raft request' (duration: 240.366353ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T04:59:52.485282Z","caller":"traceutil/trace.go:171","msg":"trace[630133267] transaction","detail":"{read_only:false; response_revision:1331; number_of_response:1; }","duration":"163.447517ms","start":"2026-07-30T04:59:52.321798Z","end":"2026-07-30T04:59:52.485245Z","steps":["trace[630133267] 'process raft request' (duration: 163.191872ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T05:00:15.410839Z","caller":"traceutil/trace.go:171","msg":"trace[2058208988] transaction","detail":"{read_only:false; response_revision:1641; number_of_response:1; }","duration":"143.92907ms","start":"2026-07-30T05:00:15.266866Z","end":"2026-07-30T05:00:15.410795Z","steps":["trace[2058208988] 'process raft request' (duration: 132.102681ms)","trace[2058208988] 'compare' (duration: 11.655696ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T05:00:44.308078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.569118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11911"} {"level":"info","ts":"2026-07-30T05:00:44.308228Z","caller":"traceutil/trace.go:171","msg":"trace[1845050645] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2119; }","duration":"223.788422ms","start":"2026-07-30T05:00:44.084409Z","end":"2026-07-30T05:00:44.308197Z","steps":["trace[1845050645] 'range keys from in-memory index tree' (duration: 223.292513ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T05:00:44.308602Z","caller":"traceutil/trace.go:171","msg":"trace[1364791973] transaction","detail":"{read_only:false; response_revision:2120; number_of_response:1; }","duration":"104.632701ms","start":"2026-07-30T05:00:44.203954Z","end":"2026-07-30T05:00:44.308587Z","steps":["trace[1364791973] 'process raft request' (duration: 26.42771ms)","trace[1364791973] 'compare' (duration: 77.786053ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T05:00:44.689674Z","caller":"traceutil/trace.go:171","msg":"trace[247428012] linearizableReadLoop","detail":"{readStateIndex:2203; appliedIndex:2202; }","duration":"157.019794ms","start":"2026-07-30T05:00:44.532621Z","end":"2026-07-30T05:00:44.689641Z","steps":["trace[247428012] 'read index received' (duration: 108.314251ms)","trace[247428012] 'applied index is now lower than readState.Index' (duration: 48.703642ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T05:00:44.689879Z","caller":"traceutil/trace.go:171","msg":"trace[68555557] transaction","detail":"{read_only:false; response_revision:2121; number_of_response:1; }","duration":"206.759966ms","start":"2026-07-30T05:00:44.483078Z","end":"2026-07-30T05:00:44.689838Z","steps":["trace[68555557] 'process raft request' (duration: 157.89549ms)","trace[68555557] 'compare' (duration: 48.347507ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T05:00:44.690004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.37378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-07-30T05:00:44.690072Z","caller":"traceutil/trace.go:171","msg":"trace[355998709] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2121; }","duration":"157.502232ms","start":"2026-07-30T05:00:44.532548Z","end":"2026-07-30T05:00:44.69005Z","steps":["trace[355998709] 'agreement among raft nodes before linearized reading' (duration: 157.223537ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T05:00:51.734628Z","caller":"traceutil/trace.go:171","msg":"trace[1223868720] transaction","detail":"{read_only:false; response_revision:2183; number_of_response:1; }","duration":"175.306923ms","start":"2026-07-30T05:00:51.559288Z","end":"2026-07-30T05:00:51.734595Z","steps":["trace[1223868720] 'process raft request' (duration: 162.938643ms)","trace[1223868720] 'compare' (duration: 12.220667ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T05:00:51.73712Z","caller":"traceutil/trace.go:171","msg":"trace[2007737598] transaction","detail":"{read_only:false; response_revision:2184; number_of_response:1; }","duration":"141.941434ms","start":"2026-07-30T05:00:51.595126Z","end":"2026-07-30T05:00:51.737068Z","steps":["trace[2007737598] 'process raft request' (duration: 141.450725ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T05:00:55.647799Z","caller":"traceutil/trace.go:171","msg":"trace[783409476] transaction","detail":"{read_only:false; response_revision:2223; number_of_response:1; }","duration":"263.273244ms","start":"2026-07-30T05:00:55.384463Z","end":"2026-07-30T05:00:55.647736Z","steps":["trace[783409476] 'process raft request' (duration: 262.985919ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T05:01:17.95947Z","caller":"traceutil/trace.go:171","msg":"trace[868699093] transaction","detail":"{read_only:false; response_revision:2381; number_of_response:1; }","duration":"156.770487ms","start":"2026-07-30T05:01:17.80267Z","end":"2026-07-30T05:01:17.959441Z","steps":["trace[868699093] 'process raft request' (duration: 91.088241ms)","trace[868699093] 'compare' (duration: 65.437301ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T05:01:17.959894Z","caller":"traceutil/trace.go:171","msg":"trace[836962160] transaction","detail":"{read_only:false; response_revision:2382; number_of_response:1; }","duration":"137.391395ms","start":"2026-07-30T05:01:17.822478Z","end":"2026-07-30T05:01:17.959869Z","steps":["trace[836962160] 'process raft request' (duration: 136.892885ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T05:01:17.959946Z","caller":"traceutil/trace.go:171","msg":"trace[2128092632] transaction","detail":"{read_only:false; response_revision:2383; number_of_response:1; }","duration":"135.810685ms","start":"2026-07-30T05:01:17.824092Z","end":"2026-07-30T05:01:17.959903Z","steps":["trace[2128092632] 'process raft request' (duration: 135.52097ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T05:01:19.08093Z","caller":"traceutil/trace.go:171","msg":"trace[1439481269] linearizableReadLoop","detail":"{readStateIndex:2479; appliedIndex:2478; }","duration":"230.138328ms","start":"2026-07-30T05:01:18.850766Z","end":"2026-07-30T05:01:19.080905Z","steps":["trace[1439481269] 'read index received' (duration: 229.899774ms)","trace[1439481269] 'applied index is now lower than readState.Index' (duration: 236.864µs)"],"step_count":2} {"level":"info","ts":"2026-07-30T05:01:19.080981Z","caller":"traceutil/trace.go:171","msg":"trace[59518734] transaction","detail":"{read_only:false; response_revision:2389; number_of_response:1; }","duration":"264.471209ms","start":"2026-07-30T05:01:18.816474Z","end":"2026-07-30T05:01:19.080945Z","steps":["trace[59518734] 'process raft request' (duration: 264.199404ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T05:01:19.081309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.494544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1988"} {"level":"info","ts":"2026-07-30T05:01:19.081414Z","caller":"traceutil/trace.go:171","msg":"trace[212195874] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:2389; }","duration":"230.679488ms","start":"2026-07-30T05:01:18.850705Z","end":"2026-07-30T05:01:19.081384Z","steps":["trace[212195874] 'agreement among raft nodes before linearized reading' (duration: 230.351832ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T05:01:19.162144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.122602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-07-30T05:01:19.162187Z","caller":"traceutil/trace.go:171","msg":"trace[1182913523] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2390; }","duration":"219.204133ms","start":"2026-07-30T05:01:18.94297Z","end":"2026-07-30T05:01:19.162174Z","steps":["trace[1182913523] 'agreement among raft nodes before linearized reading' (duration: 219.099701ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T05:01:19.162332Z","caller":"traceutil/trace.go:171","msg":"trace[1215199426] transaction","detail":"{read_only:false; response_revision:2390; number_of_response:1; }","duration":"258.538318ms","start":"2026-07-30T05:01:18.90373Z","end":"2026-07-30T05:01:19.162268Z","steps":["trace[1215199426] 'process raft request' (duration: 258.219882ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T05:01:19.162421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.246269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-30T05:01:19.162481Z","caller":"traceutil/trace.go:171","msg":"trace[1242568156] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2390; }","duration":"200.353582ms","start":"2026-07-30T05:01:18.962109Z","end":"2026-07-30T05:01:19.162463Z","steps":["trace[1242568156] 'agreement among raft nodes before linearized reading' (duration: 200.156948ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T05:01:19.162638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.395172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-07-30T05:01:19.162727Z","caller":"traceutil/trace.go:171","msg":"trace[2088787346] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2390; }","duration":"200.532595ms","start":"2026-07-30T05:01:18.962175Z","end":"2026-07-30T05:01:19.162707Z","steps":["trace[2088787346] 'agreement among raft nodes before linearized reading' (duration: 200.166148ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T05:01:19.350189Z","caller":"traceutil/trace.go:171","msg":"trace[42293864] transaction","detail":"{read_only:false; response_revision:2392; number_of_response:1; }","duration":"183.053849ms","start":"2026-07-30T05:01:19.167105Z","end":"2026-07-30T05:01:19.350159Z","steps":["trace[42293864] 'process raft request' (duration: 85.712551ms)","trace[42293864] 'compare' (duration: 96.89459ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T05:01:19.350694Z","caller":"traceutil/trace.go:171","msg":"trace[1761589457] transaction","detail":"{read_only:false; response_revision:2393; number_of_response:1; }","duration":"183.18892ms","start":"2026-07-30T05:01:19.167432Z","end":"2026-07-30T05:01:19.350621Z","steps":["trace[1761589457] 'process raft request' (duration: 182.63189ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T05:01:19.35039Z","caller":"traceutil/trace.go:171","msg":"trace[961195223] linearizableReadLoop","detail":"{readStateIndex:2483; appliedIndex:2481; }","duration":"111.851638ms","start":"2026-07-30T05:01:19.238496Z","end":"2026-07-30T05:01:19.350348Z","steps":["trace[961195223] 'read index received' (duration: 14.318107ms)","trace[961195223] 'applied index is now lower than readState.Index' (duration: 97.531671ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T05:01:19.350966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.445209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-07-30T05:01:19.351102Z","caller":"traceutil/trace.go:171","msg":"trace[263380892] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2393; }","duration":"112.614682ms","start":"2026-07-30T05:01:19.238454Z","end":"2026-07-30T05:01:19.351068Z","steps":["trace[263380892] 'agreement among raft nodes before linearized reading' (duration: 112.250806ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T05:03:28.661131Z","caller":"traceutil/trace.go:171","msg":"trace[1094578314] transaction","detail":"{read_only:false; response_revision:3301; number_of_response:1; }","duration":"186.72851ms","start":"2026-07-30T05:03:28.474375Z","end":"2026-07-30T05:03:28.661103Z","steps":["trace[1094578314] 'process raft request' (duration: 116.255593ms)","trace[1094578314] 'compare' (duration: 70.368855ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T05:03:28.692619Z","caller":"traceutil/trace.go:171","msg":"trace[1289720409] linearizableReadLoop","detail":"{readStateIndex:3419; appliedIndex:3417; }","duration":"115.544248ms","start":"2026-07-30T05:03:28.577044Z","end":"2026-07-30T05:03:28.692589Z","steps":["trace[1289720409] 'read index received' (duration: 13.60336ms)","trace[1289720409] 'applied index is now lower than readState.Index' (duration: 101.938928ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T05:03:28.692857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.790683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-30T05:03:28.692916Z","caller":"traceutil/trace.go:171","msg":"trace[1994284117] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3302; }","duration":"115.885625ms","start":"2026-07-30T05:03:28.577003Z","end":"2026-07-30T05:03:28.692889Z","steps":["trace[1994284117] 'agreement among raft nodes before linearized reading' (duration: 115.700581ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T05:03:28.692936Z","caller":"traceutil/trace.go:171","msg":"trace[1050784660] transaction","detail":"{read_only:false; response_revision:3302; number_of_response:1; }","duration":"202.993769ms","start":"2026-07-30T05:03:28.489753Z","end":"2026-07-30T05:03:28.692746Z","steps":["trace[1050784660] 'process raft request' (duration: 202.677153ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T05:07:48.702365Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3011} {"level":"info","ts":"2026-07-30T05:07:48.806171Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3011,"took":"101.087187ms","hash":865210068,"current-db-size-bytes":35532800,"current-db-size":"36 MB","current-db-size-in-use-bytes":8613888,"current-db-size-in-use":"8.6 MB"} {"level":"info","ts":"2026-07-30T05:07:48.806279Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":865210068,"revision":3011,"compact-revision":-1} {"level":"info","ts":"2026-07-30T05:12:48.710275Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":4966} {"level":"info","ts":"2026-07-30T05:12:48.753547Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":4966,"took":"41.541324ms","hash":1174268655,"current-db-size-bytes":35532800,"current-db-size":"36 MB","current-db-size-in-use-bytes":11726848,"current-db-size-in-use":"12 MB"} {"level":"info","ts":"2026-07-30T05:12:48.753631Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1174268655,"revision":4966,"compact-revision":3011} {"level":"info","ts":"2026-07-30T05:16:04.90205Z","caller":"traceutil/trace.go:171","msg":"trace[16434251] transaction","detail":"{read_only:false; response_revision:8848; number_of_response:1; }","duration":"104.032841ms","start":"2026-07-30T05:16:04.797987Z","end":"2026-07-30T05:16:04.90202Z","steps":["trace[16434251] 'process raft request' (duration: 103.844498ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T05:16:04.965823Z","caller":"traceutil/trace.go:171","msg":"trace[1840493735] transaction","detail":"{read_only:false; response_revision:8849; number_of_response:1; }","duration":"164.890717ms","start":"2026-07-30T05:16:04.800914Z","end":"2026-07-30T05:16:04.965805Z","steps":["trace[1840493735] 'process raft request' (duration: 164.52785ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T05:17:48.717477Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7245} {"level":"info","ts":"2026-07-30T05:17:48.773518Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7245,"took":"54.480403ms","hash":4054049579,"current-db-size-bytes":35532800,"current-db-size":"36 MB","current-db-size-in-use-bytes":12988416,"current-db-size-in-use":"13 MB"} {"level":"info","ts":"2026-07-30T05:17:48.773573Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4054049579,"revision":7245,"compact-revision":4966} {"level":"info","ts":"2026-07-30T05:17:54.022385Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"51a5c416a4d98c86","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-30T05:17:54.029172Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-07-30T05:17:54.029305Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-07-30T05:21:18.918135Z","caller":"traceutil/trace.go:171","msg":"trace[1328387404] transaction","detail":"{read_only:false; response_revision:11391; number_of_response:1; }","duration":"101.161757ms","start":"2026-07-30T05:21:18.816943Z","end":"2026-07-30T05:21:18.918105Z","steps":["trace[1328387404] 'process raft request' (duration: 100.984844ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T05:22:48.724105Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9656} {"level":"info","ts":"2026-07-30T05:22:48.787491Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9656,"took":"61.58762ms","hash":3352963105,"current-db-size-bytes":35532800,"current-db-size":"36 MB","current-db-size-in-use-bytes":14499840,"current-db-size-in-use":"14 MB"} {"level":"info","ts":"2026-07-30T05:22:48.787555Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3352963105,"revision":9656,"compact-revision":7245} {"level":"warn","ts":"2026-07-30T05:27:26.026397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.631686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-07-30T05:27:26.026496Z","caller":"traceutil/trace.go:171","msg":"trace[1470282459] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:14347; }","duration":"242.80655ms","start":"2026-07-30T05:27:25.783668Z","end":"2026-07-30T05:27:26.026474Z","steps":["trace[1470282459] 'range keys from in-memory index tree' (duration: 242.406592ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T05:27:26.164832Z","caller":"traceutil/trace.go:171","msg":"trace[1258982691] linearizableReadLoop","detail":"{readStateIndex:14794; appliedIndex:14793; }","duration":"128.99551ms","start":"2026-07-30T05:27:26.035809Z","end":"2026-07-30T05:27:26.164805Z","steps":["trace[1258982691] 'read index received' (duration: 128.783416ms)","trace[1258982691] 'applied index is now lower than readState.Index' (duration: 210.724µs)"],"step_count":2} {"level":"info","ts":"2026-07-30T05:27:26.164917Z","caller":"traceutil/trace.go:171","msg":"trace[458916344] transaction","detail":"{read_only:false; response_revision:14348; number_of_response:1; }","duration":"133.679929ms","start":"2026-07-30T05:27:26.031208Z","end":"2026-07-30T05:27:26.164888Z","steps":["trace[458916344] 'process raft request' (duration: 133.407314ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T05:27:26.165136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.300995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-30T05:27:26.165174Z","caller":"traceutil/trace.go:171","msg":"trace[267716299] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14348; }","duration":"129.385607ms","start":"2026-07-30T05:27:26.035779Z","end":"2026-07-30T05:27:26.165164Z","steps":["trace[267716299] 'agreement among raft nodes before linearized reading' (duration: 129.173893ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T05:27:26.181003Z","caller":"traceutil/trace.go:171","msg":"trace[140625141] transaction","detail":"{read_only:false; response_revision:14349; number_of_response:1; }","duration":"141.987499ms","start":"2026-07-30T05:27:26.038998Z","end":"2026-07-30T05:27:26.180986Z","steps":["trace[140625141] 'process raft request' (duration: 141.802365ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T05:27:48.731571Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12084} {"level":"info","ts":"2026-07-30T05:27:48.791273Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12084,"took":"57.670584ms","hash":1364341914,"current-db-size-bytes":35532800,"current-db-size":"36 MB","current-db-size-in-use-bytes":17190912,"current-db-size-in-use":"17 MB"} {"level":"info","ts":"2026-07-30T05:27:48.79136Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1364341914,"revision":12084,"compact-revision":9656} {"level":"info","ts":"2026-07-30T05:29:03.257472Z","caller":"traceutil/trace.go:171","msg":"trace[255894380] transaction","detail":"{read_only:false; response_revision:15521; number_of_response:1; }","duration":"328.638533ms","start":"2026-07-30T05:29:02.928799Z","end":"2026-07-30T05:29:03.257438Z","steps":["trace[255894380] 'process raft request' (duration: 328.434339ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T05:29:03.257885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T05:29:02.928776Z","time spent":"328.795835ms","remote":"127.0.0.1:36804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T05:29:03.25896Z","caller":"traceutil/trace.go:171","msg":"trace[184045181] linearizableReadLoop","detail":"{readStateIndex:16005; appliedIndex:16001; }","duration":"116.698085ms","start":"2026-07-30T05:29:03.14224Z","end":"2026-07-30T05:29:03.258938Z","steps":["trace[184045181] 'read index received' (duration: 115.011352ms)","trace[184045181] 'applied index is now lower than readState.Index' (duration: 1.685783ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T05:29:03.259041Z","caller":"traceutil/trace.go:171","msg":"trace[1079781250] transaction","detail":"{read_only:false; response_revision:15523; number_of_response:1; }","duration":"328.093363ms","start":"2026-07-30T05:29:02.930928Z","end":"2026-07-30T05:29:03.259021Z","steps":["trace[1079781250] 'process raft request' (duration: 327.853828ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T05:29:03.259034Z","caller":"traceutil/trace.go:171","msg":"trace[51395505] transaction","detail":"{read_only:false; response_revision:15522; number_of_response:1; }","duration":"329.288506ms","start":"2026-07-30T05:29:02.929697Z","end":"2026-07-30T05:29:03.258986Z","steps":["trace[51395505] 'process raft request' (duration: 328.96355ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T05:29:03.259129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T05:29:02.930895Z","time spent":"328.193324ms","remote":"127.0.0.1:36804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T05:29:03.259202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T05:29:02.929655Z","time spent":"329.451799ms","remote":"127.0.0.1:36804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T05:29:03.259301Z","caller":"traceutil/trace.go:171","msg":"trace[738012344] transaction","detail":"{read_only:false; response_revision:15524; number_of_response:1; }","duration":"194.209278ms","start":"2026-07-30T05:29:03.064933Z","end":"2026-07-30T05:29:03.259142Z","steps":["trace[738012344] 'process raft request' (duration: 193.967223ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T05:29:03.259381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.125873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-07-30T05:29:03.259579Z","caller":"traceutil/trace.go:171","msg":"trace[999921825] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:15524; }","duration":"117.324007ms","start":"2026-07-30T05:29:03.142181Z","end":"2026-07-30T05:29:03.259505Z","steps":["trace[999921825] 'agreement among raft nodes before linearized reading' (duration: 117.064812ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T05:32:48.738666Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14698} {"level":"info","ts":"2026-07-30T05:32:48.821527Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14698,"took":"80.907708ms","hash":3396060871,"current-db-size-bytes":35532800,"current-db-size":"36 MB","current-db-size-in-use-bytes":15876096,"current-db-size-in-use":"16 MB"} {"level":"info","ts":"2026-07-30T05:32:48.821637Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3396060871,"revision":14698,"compact-revision":12084} {"level":"info","ts":"2026-07-30T05:37:45.008058Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"51a5c416a4d98c86","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-30T05:37:45.014063Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-07-30T05:37:45.014219Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-07-30T05:37:48.746345Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17017} {"level":"info","ts":"2026-07-30T05:37:48.832222Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17017,"took":"82.053841ms","hash":2900324679,"current-db-size-bytes":35532800,"current-db-size":"36 MB","current-db-size-in-use-bytes":17780736,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-30T05:37:48.832296Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2900324679,"revision":17017,"compact-revision":14698} {"level":"info","ts":"2026-07-30T05:41:44.87128Z","caller":"traceutil/trace.go:171","msg":"trace[1480364011] linearizableReadLoop","detail":"{readStateIndex:21795; appliedIndex:21794; }","duration":"146.241178ms","start":"2026-07-30T05:41:44.725005Z","end":"2026-07-30T05:41:44.871246Z","steps":["trace[1480364011] 'read index received' (duration: 145.979773ms)","trace[1480364011] 'applied index is now lower than readState.Index' (duration: 259.945µs)"],"step_count":2} {"level":"info","ts":"2026-07-30T05:41:44.871704Z","caller":"traceutil/trace.go:171","msg":"trace[433899731] transaction","detail":"{read_only:false; response_revision:21146; number_of_response:1; }","duration":"191.076686ms","start":"2026-07-30T05:41:44.680612Z","end":"2026-07-30T05:41:44.871689Z","steps":["trace[433899731] 'process raft request' (duration: 190.414914ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T05:41:44.871686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.650236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-07-30T05:41:44.871891Z","caller":"traceutil/trace.go:171","msg":"trace[1219148993] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:21146; }","duration":"146.930122ms","start":"2026-07-30T05:41:44.72493Z","end":"2026-07-30T05:41:44.87186Z","steps":["trace[1219148993] 'agreement among raft nodes before linearized reading' (duration: 146.556425ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T05:41:44.871941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.564934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-07-30T05:41:44.872069Z","caller":"traceutil/trace.go:171","msg":"trace[839744042] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:21146; }","duration":"146.719858ms","start":"2026-07-30T05:41:44.725317Z","end":"2026-07-30T05:41:44.872037Z","steps":["trace[839744042] 'agreement among raft nodes before linearized reading' (duration: 146.384222ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T05:41:51.65559Z","caller":"traceutil/trace.go:171","msg":"trace[1113436044] transaction","detail":"{read_only:false; response_revision:21199; number_of_response:1; }","duration":"288.118365ms","start":"2026-07-30T05:41:51.367411Z","end":"2026-07-30T05:41:51.655529Z","steps":["trace[1113436044] 'process raft request' (duration: 272.789941ms)","trace[1113436044] 'compare' (duration: 15.14137ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T05:41:51.878018Z","caller":"traceutil/trace.go:171","msg":"trace[2193922] transaction","detail":"{read_only:false; response_revision:21200; number_of_response:1; }","duration":"327.732853ms","start":"2026-07-30T05:41:51.550248Z","end":"2026-07-30T05:41:51.877981Z","steps":["trace[2193922] 'process raft request' (duration: 308.987913ms)","trace[2193922] 'compare' (duration: 18.431044ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T05:41:51.878253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T05:41:51.550209Z","time spent":"327.908896ms","remote":"127.0.0.1:36804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T05:41:51.878279Z","caller":"traceutil/trace.go:171","msg":"trace[1291175637] linearizableReadLoop","detail":"{readStateIndex:21852; appliedIndex:21850; }","duration":"212.013949ms","start":"2026-07-30T05:41:51.66623Z","end":"2026-07-30T05:41:51.878244Z","steps":["trace[1291175637] 'read index received' (duration: 193.254989ms)","trace[1291175637] 'applied index is now lower than readState.Index' (duration: 18.7578ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T05:41:51.878346Z","caller":"traceutil/trace.go:171","msg":"trace[827449395] transaction","detail":"{read_only:false; response_revision:21201; number_of_response:1; }","duration":"323.418389ms","start":"2026-07-30T05:41:51.554896Z","end":"2026-07-30T05:41:51.878314Z","steps":["trace[827449395] 'process raft request' (duration: 323.010851ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T05:41:51.878455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T05:41:51.55488Z","time spent":"323.520662ms","remote":"127.0.0.1:36804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T05:41:51.878503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.279373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-hzkz9\" ","response":"range_response_count:1 size:20664"} {"level":"info","ts":"2026-07-30T05:41:51.878549Z","caller":"traceutil/trace.go:171","msg":"trace[1327789064] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-hzkz9; range_end:; response_count:1; response_revision:21202; }","duration":"212.381835ms","start":"2026-07-30T05:41:51.66615Z","end":"2026-07-30T05:41:51.878532Z","steps":["trace[1327789064] 'agreement among raft nodes before linearized reading' (duration: 212.235332ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T05:41:51.878782Z","caller":"traceutil/trace.go:171","msg":"trace[321718819] transaction","detail":"{read_only:false; response_revision:21202; number_of_response:1; }","duration":"158.199557ms","start":"2026-07-30T05:41:51.720234Z","end":"2026-07-30T05:41:51.878433Z","steps":["trace[321718819] 'process raft request' (duration: 157.925132ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T05:42:38.636585Z","caller":"traceutil/trace.go:171","msg":"trace[1084407696] transaction","detail":"{read_only:false; response_revision:21682; number_of_response:1; }","duration":"130.13458ms","start":"2026-07-30T05:42:38.506413Z","end":"2026-07-30T05:42:38.636548Z","steps":["trace[1084407696] 'process raft request' (duration: 129.62453ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T05:42:41.046032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.690474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-30T05:42:41.046154Z","caller":"traceutil/trace.go:171","msg":"trace[1368935354] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:21700; }","duration":"244.905218ms","start":"2026-07-30T05:42:40.801223Z","end":"2026-07-30T05:42:41.046128Z","steps":["trace[1368935354] 'count revisions from in-memory index tree' (duration: 244.493789ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T05:42:43.838272Z","caller":"traceutil/trace.go:171","msg":"trace[704705224] transaction","detail":"{read_only:false; response_revision:21728; number_of_response:1; }","duration":"148.773748ms","start":"2026-07-30T05:42:43.689472Z","end":"2026-07-30T05:42:43.838245Z","steps":["trace[704705224] 'process raft request' (duration: 148.722057ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T05:42:43.838327Z","caller":"traceutil/trace.go:171","msg":"trace[482427914] transaction","detail":"{read_only:false; response_revision:21727; number_of_response:1; }","duration":"197.01355ms","start":"2026-07-30T05:42:43.641278Z","end":"2026-07-30T05:42:43.838291Z","steps":["trace[482427914] 'process raft request' (duration: 170.809419ms)","trace[482427914] 'compare' (duration: 25.981537ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T05:42:48.757373Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19430} {"level":"info","ts":"2026-07-30T05:42:48.833484Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19430,"took":"73.530077ms","hash":4150889387,"current-db-size-bytes":35532800,"current-db-size":"36 MB","current-db-size-in-use-bytes":18055168,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-30T05:42:48.833551Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4150889387,"revision":19430,"compact-revision":17017} {"level":"info","ts":"2026-07-30T05:43:16.245514Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000587c.wal"} {"level":"info","ts":"2026-07-30T05:47:48.763734Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21769} {"level":"info","ts":"2026-07-30T05:47:48.84294Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21769,"took":"76.452382ms","hash":1086940390,"current-db-size-bytes":35532800,"current-db-size":"36 MB","current-db-size-in-use-bytes":18866176,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-07-30T05:47:48.843038Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1086940390,"revision":21769,"compact-revision":19430} {"level":"info","ts":"2026-07-30T05:52:48.773465Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23997} {"level":"info","ts":"2026-07-30T05:52:48.866646Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23997,"took":"90.349168ms","hash":1877259690,"current-db-size-bytes":35532800,"current-db-size":"36 MB","current-db-size-in-use-bytes":16048128,"current-db-size-in-use":"16 MB"} {"level":"info","ts":"2026-07-30T05:52:48.866731Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1877259690,"revision":23997,"compact-revision":21769} {"level":"info","ts":"2026-07-30T05:57:48.77954Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26066} {"level":"info","ts":"2026-07-30T05:57:48.86538Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26066,"took":"83.019458ms","hash":3619176981,"current-db-size-bytes":35532800,"current-db-size":"36 MB","current-db-size-in-use-bytes":15175680,"current-db-size-in-use":"15 MB"} {"level":"info","ts":"2026-07-30T05:57:48.865464Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3619176981,"revision":26066,"compact-revision":23997} {"level":"info","ts":"2026-07-30T06:00:28.201492Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"51a5c416a4d98c86","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-30T06:00:28.20733Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-07-30T06:00:28.20747Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}