{"level":"warn","ts":"2026-09-02T16:27:00.598806Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-02T16:27:00.598972Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.140: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.140:2380","--initial-cluster=instance=https://162.253.55.140:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.140:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.140:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-09-02T16:27:00.599098Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-02T16:27:00.599127Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.140:2380"]} {"level":"info","ts":"2026-09-02T16:27:00.599168Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-02T16:27:00.600486Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.140:2379"]} {"level":"info","ts":"2026-09-02T16:27:00.600686Z","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.140:2380"],"listen-peer-urls":["https://162.253.55.140:2380"],"advertise-client-urls":["https://162.253.55.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.140:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-09-02T16:27:00.603841Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.692189ms"} {"level":"info","ts":"2026-09-02T16:27:00.610863Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cf809824ab95ac81","cluster-id":"6f89f5fbef18dc61"} {"level":"info","ts":"2026-09-02T16:27:00.610999Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=()"} {"level":"info","ts":"2026-09-02T16:27:00.611035Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became follower at term 0"} {"level":"info","ts":"2026-09-02T16:27:00.611065Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cf809824ab95ac81 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-02T16:27:00.611084Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became follower at term 1"} {"level":"info","ts":"2026-09-02T16:27:00.611152Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=(14952118046135004289)"} {"level":"warn","ts":"2026-09-02T16:27:00.617444Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-02T16:27:00.619617Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-02T16:27:00.621782Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-09-02T16:27:00.625207Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cf809824ab95ac81","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-02T16:27:00.625727Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cf809824ab95ac81","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-02T16:27:00.625923Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-02T16:27:00.626115Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-02T16:27:00.626151Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-02T16:27:00.628235Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=(14952118046135004289)"} {"level":"info","ts":"2026-09-02T16:27:00.628564Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6f89f5fbef18dc61","local-member-id":"cf809824ab95ac81","added-peer-id":"cf809824ab95ac81","added-peer-peer-urls":["https://162.253.55.140:2380"]} {"level":"info","ts":"2026-09-02T16:27:00.631978Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-02T16:27:00.632147Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.140:2380"} {"level":"info","ts":"2026-09-02T16:27:00.632256Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.140:2380"} {"level":"info","ts":"2026-09-02T16:27:00.632311Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cf809824ab95ac81","initial-advertise-peer-urls":["https://162.253.55.140:2380"],"listen-peer-urls":["https://162.253.55.140:2380"],"advertise-client-urls":["https://162.253.55.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-02T16:27:00.632372Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-02T16:27:01.311936Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 is starting a new election at term 1"} {"level":"info","ts":"2026-09-02T16:27:01.31199Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-02T16:27:01.312033Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 received MsgPreVoteResp from cf809824ab95ac81 at term 1"} {"level":"info","ts":"2026-09-02T16:27:01.312049Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became candidate at term 2"} {"level":"info","ts":"2026-09-02T16:27:01.312054Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 received MsgVoteResp from cf809824ab95ac81 at term 2"} {"level":"info","ts":"2026-09-02T16:27:01.312062Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became leader at term 2"} {"level":"info","ts":"2026-09-02T16:27:01.31207Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cf809824ab95ac81 elected leader cf809824ab95ac81 at term 2"} {"level":"info","ts":"2026-09-02T16:27:01.313576Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-02T16:27:01.314441Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cf809824ab95ac81","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.140:2379]}","request-path":"/0/members/cf809824ab95ac81/attributes","cluster-id":"6f89f5fbef18dc61","publish-timeout":"7s"} {"level":"info","ts":"2026-09-02T16:27:01.31468Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-02T16:27:01.3148Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-02T16:27:01.315274Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-02T16:27:01.315339Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6f89f5fbef18dc61","local-member-id":"cf809824ab95ac81","cluster-version":"3.5"} {"level":"info","ts":"2026-09-02T16:27:01.315389Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-02T16:27:01.315524Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-02T16:27:01.315678Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-02T16:27:01.31828Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.140:2379"} {"level":"info","ts":"2026-09-02T16:27:01.318465Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-02T16:27:27.028926Z","caller":"traceutil/trace.go:171","msg":"trace[1062470158] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"198.18806ms","start":"2026-09-02T16:27:26.830696Z","end":"2026-09-02T16:27:27.028884Z","steps":["trace[1062470158] 'process raft request' (duration: 198.007226ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:27:44.384465Z","caller":"traceutil/trace.go:171","msg":"trace[1775012573] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:652; }","duration":"171.41314ms","start":"2026-09-02T16:27:44.21298Z","end":"2026-09-02T16:27:44.384393Z","steps":["trace[1775012573] 'read index received' (duration: 165.050091ms)","trace[1775012573] 'applied index is now lower than readState.Index' (duration: 6.361719ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:27:44.384614Z","caller":"traceutil/trace.go:171","msg":"trace[151529117] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"181.97994ms","start":"2026-09-02T16:27:44.202603Z","end":"2026-09-02T16:27:44.384583Z","steps":["trace[151529117] 'process raft request' (duration: 179.433634ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:27:44.384749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.745876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-02T16:27:44.384944Z","caller":"traceutil/trace.go:171","msg":"trace[1998198077] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:630; }","duration":"171.960211ms","start":"2026-09-02T16:27:44.212963Z","end":"2026-09-02T16:27:44.384923Z","steps":["trace[1998198077] 'agreement among raft nodes before linearized reading' (duration: 171.651764ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:27:44.394163Z","caller":"traceutil/trace.go:171","msg":"trace[604289250] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"150.038753ms","start":"2026-09-02T16:27:44.24409Z","end":"2026-09-02T16:27:44.394129Z","steps":["trace[604289250] 'process raft request' (duration: 149.87521ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:27:44.613871Z","caller":"traceutil/trace.go:171","msg":"trace[2034228693] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"152.575158ms","start":"2026-09-02T16:27:44.461261Z","end":"2026-09-02T16:27:44.613836Z","steps":["trace[2034228693] 'process raft request' (duration: 152.301332ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:27:44.792666Z","caller":"traceutil/trace.go:171","msg":"trace[1452549387] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:655; }","duration":"119.449916ms","start":"2026-09-02T16:27:44.67317Z","end":"2026-09-02T16:27:44.79262Z","steps":["trace[1452549387] 'read index received' (duration: 90.3462ms)","trace[1452549387] 'applied index is now lower than readState.Index' (duration: 29.102366ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T16:27:44.792889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.679832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.140\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-09-02T16:27:44.792948Z","caller":"traceutil/trace.go:171","msg":"trace[92335152] range","detail":"{range_begin:/registry/masterleases/162.253.55.140; range_end:; response_count:1; response_revision:633; }","duration":"119.845605ms","start":"2026-09-02T16:27:44.673083Z","end":"2026-09-02T16:27:44.792928Z","steps":["trace[92335152] 'agreement among raft nodes before linearized reading' (duration: 119.686241ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:27:44.793022Z","caller":"traceutil/trace.go:171","msg":"trace[1920778425] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"160.055212ms","start":"2026-09-02T16:27:44.632943Z","end":"2026-09-02T16:27:44.792999Z","steps":["trace[1920778425] 'process raft request' (duration: 130.554398ms)","trace[1920778425] 'compare' (duration: 28.927022ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:27:45.265113Z","caller":"traceutil/trace.go:171","msg":"trace[40958390] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"165.158274ms","start":"2026-09-02T16:27:45.09992Z","end":"2026-09-02T16:27:45.265078Z","steps":["trace[40958390] 'process raft request' (duration: 164.446937ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:29:26.461407Z","caller":"traceutil/trace.go:171","msg":"trace[1950718554] transaction","detail":"{read_only:false; response_revision:1917; number_of_response:1; }","duration":"143.56692ms","start":"2026-09-02T16:29:26.317813Z","end":"2026-09-02T16:29:26.46138Z","steps":["trace[1950718554] 'process raft request' (duration: 143.349495ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:29:26.749073Z","caller":"traceutil/trace.go:171","msg":"trace[1830595352] transaction","detail":"{read_only:false; response_revision:1919; number_of_response:1; }","duration":"144.382487ms","start":"2026-09-02T16:29:26.604643Z","end":"2026-09-02T16:29:26.749026Z","steps":["trace[1830595352] 'process raft request' (duration: 107.506706ms)","trace[1830595352] 'compare' (duration: 36.669847ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:29:41.18209Z","caller":"traceutil/trace.go:171","msg":"trace[1125048099] transaction","detail":"{read_only:false; response_revision:2040; number_of_response:1; }","duration":"121.107212ms","start":"2026-09-02T16:29:41.060956Z","end":"2026-09-02T16:29:41.182063Z","steps":["trace[1125048099] 'process raft request' (duration: 120.949788ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:30:10.44217Z","caller":"traceutil/trace.go:171","msg":"trace[49454711] linearizableReadLoop","detail":"{readStateIndex:2291; appliedIndex:2289; }","duration":"323.031671ms","start":"2026-09-02T16:30:10.119114Z","end":"2026-09-02T16:30:10.442145Z","steps":["trace[49454711] 'read index received' (duration: 90.609921ms)","trace[49454711] 'applied index is now lower than readState.Index' (duration: 232.42072ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:30:10.442229Z","caller":"traceutil/trace.go:171","msg":"trace[1673174638] transaction","detail":"{read_only:false; response_revision:2206; number_of_response:1; }","duration":"323.592452ms","start":"2026-09-02T16:30:10.118607Z","end":"2026-09-02T16:30:10.442199Z","steps":["trace[1673174638] 'process raft request' (duration: 243.358996ms)","trace[1673174638] 'compare' (duration: 80.064853ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T16:30:10.442388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.972541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-09-02T16:30:10.442419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.297417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-09-02T16:30:10.442466Z","caller":"traceutil/trace.go:171","msg":"trace[1534478491] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2206; }","duration":"318.071234ms","start":"2026-09-02T16:30:10.124374Z","end":"2026-09-02T16:30:10.442446Z","steps":["trace[1534478491] 'agreement among raft nodes before linearized reading' (duration: 317.91469ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:30:10.442482Z","caller":"traceutil/trace.go:171","msg":"trace[1770413123] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2206; }","duration":"323.389678ms","start":"2026-09-02T16:30:10.119076Z","end":"2026-09-02T16:30:10.442465Z","steps":["trace[1770413123] 'agreement among raft nodes before linearized reading' (duration: 323.178543ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:30:10.442487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.466848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-02T16:30:10.442498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:30:10.124361Z","time spent":"318.128274ms","remote":"127.0.0.1:53178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-09-02T16:30:10.442582Z","caller":"traceutil/trace.go:171","msg":"trace[1684320889] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2206; }","duration":"230.55682ms","start":"2026-09-02T16:30:10.211985Z","end":"2026-09-02T16:30:10.442542Z","steps":["trace[1684320889] 'agreement among raft nodes before linearized reading' (duration: 230.439537ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:30:10.442542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:30:10.119063Z","time spent":"323.44833ms","remote":"127.0.0.1:53178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-02T16:30:10.442991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:30:10.118539Z","time spent":"323.743676ms","remote":"127.0.0.1:53178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-02T16:31:10.0058Z","caller":"traceutil/trace.go:171","msg":"trace[1566595594] transaction","detail":"{read_only:false; response_revision:2700; number_of_response:1; }","duration":"278.970982ms","start":"2026-09-02T16:31:09.726801Z","end":"2026-09-02T16:31:10.005772Z","steps":["trace[1566595594] 'process raft request' (duration: 278.781498ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:36:36.808324Z","caller":"traceutil/trace.go:171","msg":"trace[809396430] transaction","detail":"{read_only:false; response_revision:5375; number_of_response:1; }","duration":"147.709096ms","start":"2026-09-02T16:36:36.660585Z","end":"2026-09-02T16:36:36.808294Z","steps":["trace[809396430] 'process raft request' (duration: 134.192656ms)","trace[809396430] 'compare' (duration: 13.384827ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:36:36.841632Z","caller":"traceutil/trace.go:171","msg":"trace[189202271] linearizableReadLoop","detail":"{readStateIndex:5581; appliedIndex:5579; }","duration":"150.224899ms","start":"2026-09-02T16:36:36.691384Z","end":"2026-09-02T16:36:36.841609Z","steps":["trace[189202271] 'read index received' (duration: 103.59053ms)","trace[189202271] 'applied index is now lower than readState.Index' (duration: 46.632729ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:36:36.841702Z","caller":"traceutil/trace.go:171","msg":"trace[1401529426] transaction","detail":"{read_only:false; response_revision:5376; number_of_response:1; }","duration":"180.873445ms","start":"2026-09-02T16:36:36.660796Z","end":"2026-09-02T16:36:36.841669Z","steps":["trace[1401529426] 'process raft request' (duration: 180.583289ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:36:36.842442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.035177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:787120"} {"level":"info","ts":"2026-09-02T16:36:36.842591Z","caller":"traceutil/trace.go:171","msg":"trace[1470440572] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5376; }","duration":"151.16387ms","start":"2026-09-02T16:36:36.691344Z","end":"2026-09-02T16:36:36.842508Z","steps":["trace[1470440572] 'agreement among raft nodes before linearized reading' (duration: 150.379693ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:36:50.986566Z","caller":"traceutil/trace.go:171","msg":"trace[282869445] transaction","detail":"{read_only:false; response_revision:5624; number_of_response:1; }","duration":"131.585789ms","start":"2026-09-02T16:36:50.854961Z","end":"2026-09-02T16:36:50.986547Z","steps":["trace[282869445] 'process raft request' (duration: 131.419116ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:36:50.987186Z","caller":"traceutil/trace.go:171","msg":"trace[1842335682] linearizableReadLoop","detail":"{readStateIndex:5837; appliedIndex:5835; }","duration":"112.413919ms","start":"2026-09-02T16:36:50.874744Z","end":"2026-09-02T16:36:50.987158Z","steps":["trace[1842335682] 'read index received' (duration: 57.133934ms)","trace[1842335682] 'applied index is now lower than readState.Index' (duration: 55.279075ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T16:36:50.987419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.659254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-02T16:36:50.98748Z","caller":"traceutil/trace.go:171","msg":"trace[1010553698] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5628; }","duration":"112.733425ms","start":"2026-09-02T16:36:50.874713Z","end":"2026-09-02T16:36:50.987446Z","steps":["trace[1010553698] 'agreement among raft nodes before linearized reading' (duration: 112.570212ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:36:51.442157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.456489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-02T16:36:51.442228Z","caller":"traceutil/trace.go:171","msg":"trace[15108283] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5638; }","duration":"230.569211ms","start":"2026-09-02T16:36:51.211641Z","end":"2026-09-02T16:36:51.442211Z","steps":["trace[15108283] 'range keys from in-memory index tree' (duration: 230.370736ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:36:51.780909Z","caller":"traceutil/trace.go:171","msg":"trace[1012574769] linearizableReadLoop","detail":"{readStateIndex:5853; appliedIndex:5852; }","duration":"188.332536ms","start":"2026-09-02T16:36:51.592554Z","end":"2026-09-02T16:36:51.780886Z","steps":["trace[1012574769] 'read index received' (duration: 177.257918ms)","trace[1012574769] 'applied index is now lower than readState.Index' (duration: 11.073367ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:36:51.781157Z","caller":"traceutil/trace.go:171","msg":"trace[1493841808] transaction","detail":"{read_only:false; response_revision:5640; number_of_response:1; }","duration":"244.024609ms","start":"2026-09-02T16:36:51.537119Z","end":"2026-09-02T16:36:51.781144Z","steps":["trace[1493841808] 'process raft request' (duration: 232.688226ms)","trace[1493841808] 'compare' (duration: 10.577427ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T16:36:51.781568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.999241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-02T16:36:51.781679Z","caller":"traceutil/trace.go:171","msg":"trace[1466757850] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5640; }","duration":"189.167394ms","start":"2026-09-02T16:36:51.592486Z","end":"2026-09-02T16:36:51.781653Z","steps":["trace[1466757850] 'agreement among raft nodes before linearized reading' (duration: 188.873276ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:37:01.351064Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2998} {"level":"info","ts":"2026-09-02T16:37:01.437296Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2998,"took":"84.761906ms","hash":2542899408,"current-db-size-bytes":56946688,"current-db-size":"57 MB","current-db-size-in-use-bytes":31834112,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-09-02T16:37:01.43741Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2542899408,"revision":2998,"compact-revision":-1} {"level":"info","ts":"2026-09-02T16:42:01.360108Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5842} {"level":"info","ts":"2026-09-02T16:42:01.453008Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5842,"took":"90.055432ms","hash":2882574623,"current-db-size-bytes":56946688,"current-db-size":"57 MB","current-db-size-in-use-bytes":26320896,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-09-02T16:42:01.453113Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2882574623,"revision":5842,"compact-revision":2998} {"level":"info","ts":"2026-09-02T16:43:31.126258Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000236c.wal"} {"level":"info","ts":"2026-09-02T16:43:34.597506Z","caller":"traceutil/trace.go:171","msg":"trace[1691204817] transaction","detail":"{read_only:false; response_revision:8770; number_of_response:1; }","duration":"104.776909ms","start":"2026-09-02T16:43:34.492704Z","end":"2026-09-02T16:43:34.597481Z","steps":["trace[1691204817] 'process raft request' (duration: 87.10586ms)","trace[1691204817] 'compare' (duration: 17.463474ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:43:34.942245Z","caller":"traceutil/trace.go:171","msg":"trace[1203198971] transaction","detail":"{read_only:false; response_revision:8774; number_of_response:1; }","duration":"161.144388ms","start":"2026-09-02T16:43:34.781056Z","end":"2026-09-02T16:43:34.9422Z","steps":["trace[1203198971] 'process raft request' (duration: 110.650984ms)","trace[1203198971] 'compare' (duration: 50.074855ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:43:36.707752Z","caller":"traceutil/trace.go:171","msg":"trace[584102341] transaction","detail":"{read_only:false; response_revision:8782; number_of_response:1; }","duration":"104.036433ms","start":"2026-09-02T16:43:36.603617Z","end":"2026-09-02T16:43:36.707653Z","steps":["trace[584102341] 'process raft request' (duration: 103.866169ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:43:36.717429Z","caller":"traceutil/trace.go:171","msg":"trace[17626681] transaction","detail":"{read_only:false; response_revision:8783; number_of_response:1; }","duration":"113.69358ms","start":"2026-09-02T16:43:36.6037Z","end":"2026-09-02T16:43:36.717393Z","steps":["trace[17626681] 'process raft request' (duration: 113.481416ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:44:01.651147Z","caller":"traceutil/trace.go:171","msg":"trace[638013216] linearizableReadLoop","detail":"{readStateIndex:9290; appliedIndex:9289; }","duration":"105.249798ms","start":"2026-09-02T16:44:01.545868Z","end":"2026-09-02T16:44:01.651118Z","steps":["trace[638013216] 'read index received' (duration: 104.976182ms)","trace[638013216] 'applied index is now lower than readState.Index' (duration: 272.546µs)"],"step_count":2} {"level":"warn","ts":"2026-09-02T16:44:01.651701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.79559ms","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-09-02T16:44:01.651792Z","caller":"traceutil/trace.go:171","msg":"trace[302886742] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:8969; }","duration":"105.955694ms","start":"2026-09-02T16:44:01.545814Z","end":"2026-09-02T16:44:01.65177Z","steps":["trace[302886742] 'agreement among raft nodes before linearized reading' (duration: 105.657167ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:44:01.652162Z","caller":"traceutil/trace.go:171","msg":"trace[157642950] transaction","detail":"{read_only:false; response_revision:8969; number_of_response:1; }","duration":"145.129441ms","start":"2026-09-02T16:44:01.507007Z","end":"2026-09-02T16:44:01.652136Z","steps":["trace[157642950] 'process raft request' (duration: 143.946126ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:44:05.491934Z","caller":"traceutil/trace.go:171","msg":"trace[302407804] linearizableReadLoop","detail":"{readStateIndex:9313; appliedIndex:9312; }","duration":"153.915969ms","start":"2026-09-02T16:44:05.337999Z","end":"2026-09-02T16:44:05.491915Z","steps":["trace[302407804] 'read index received' (duration: 153.750286ms)","trace[302407804] 'applied index is now lower than readState.Index' (duration: 164.563µs)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:44:05.492046Z","caller":"traceutil/trace.go:171","msg":"trace[1548361360] transaction","detail":"{read_only:false; response_revision:8991; number_of_response:1; }","duration":"159.065498ms","start":"2026-09-02T16:44:05.332971Z","end":"2026-09-02T16:44:05.492037Z","steps":["trace[1548361360] 'process raft request' (duration: 158.794862ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:44:05.492208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.189735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-02T16:44:05.492246Z","caller":"traceutil/trace.go:171","msg":"trace[591004228] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8991; }","duration":"154.275527ms","start":"2026-09-02T16:44:05.337959Z","end":"2026-09-02T16:44:05.492235Z","steps":["trace[591004228] 'agreement among raft nodes before linearized reading' (duration: 154.198335ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:44:05.492476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.124443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-02T16:44:05.492593Z","caller":"traceutil/trace.go:171","msg":"trace[2077460736] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8991; }","duration":"153.270545ms","start":"2026-09-02T16:44:05.3393Z","end":"2026-09-02T16:44:05.49257Z","steps":["trace[2077460736] 'agreement among raft nodes before linearized reading' (duration: 152.993129ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:44:05.704536Z","caller":"traceutil/trace.go:171","msg":"trace[286260239] transaction","detail":"{read_only:false; response_revision:8992; number_of_response:1; }","duration":"207.512584ms","start":"2026-09-02T16:44:05.497001Z","end":"2026-09-02T16:44:05.704513Z","steps":["trace[286260239] 'process raft request' (duration: 151.363094ms)","trace[286260239] 'compare' (duration: 55.783532ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:44:05.704604Z","caller":"traceutil/trace.go:171","msg":"trace[865998382] transaction","detail":"{read_only:false; response_revision:8993; number_of_response:1; }","duration":"203.802774ms","start":"2026-09-02T16:44:05.500761Z","end":"2026-09-02T16:44:05.704564Z","steps":["trace[865998382] 'process raft request' (duration: 203.59993ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:44:16.503852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.203358ms","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-09-02T16:44:16.504411Z","caller":"traceutil/trace.go:171","msg":"trace[1092104585] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:9050; }","duration":"127.364511ms","start":"2026-09-02T16:44:16.376569Z","end":"2026-09-02T16:44:16.503934Z","steps":["trace[1092104585] 'count revisions from in-memory index tree' (duration: 127.076475ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:44:16.988007Z","caller":"traceutil/trace.go:171","msg":"trace[280959044] transaction","detail":"{read_only:false; response_revision:9053; number_of_response:1; }","duration":"131.373507ms","start":"2026-09-02T16:44:16.856604Z","end":"2026-09-02T16:44:16.987978Z","steps":["trace[280959044] 'process raft request' (duration: 88.998812ms)","trace[280959044] 'compare' (duration: 42.249283ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T16:44:17.326044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.023565ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-02T16:44:17.326169Z","caller":"traceutil/trace.go:171","msg":"trace[1547587058] linearizableReadLoop","detail":"{readStateIndex:9378; appliedIndex:9377; }","duration":"177.139784ms","start":"2026-09-02T16:44:17.149007Z","end":"2026-09-02T16:44:17.326147Z","steps":["trace[1547587058] 'read index received' (duration: 70.728981ms)","trace[1547587058] 'applied index is now lower than readState.Index' (duration: 106.408653ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:44:17.326276Z","caller":"traceutil/trace.go:171","msg":"trace[552353373] transaction","detail":"{read_only:false; response_revision:9054; number_of_response:1; }","duration":"227.774127ms","start":"2026-09-02T16:44:17.098485Z","end":"2026-09-02T16:44:17.326259Z","steps":["trace[552353373] 'process raft request' (duration: 121.276501ms)","trace[552353373] 'compare' (duration: 105.907473ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T16:44:17.326453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.606607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-02T16:44:17.326499Z","caller":"traceutil/trace.go:171","msg":"trace[2121306737] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9054; }","duration":"113.693329ms","start":"2026-09-02T16:44:17.212793Z","end":"2026-09-02T16:44:17.326486Z","steps":["trace[2121306737] 'agreement among raft nodes before linearized reading' (duration: 113.607458ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:44:17.326508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.25212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-09-02T16:44:17.326562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.511193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-02T16:44:17.32666Z","caller":"traceutil/trace.go:171","msg":"trace[718537417] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:9054; }","duration":"177.682996ms","start":"2026-09-02T16:44:17.148952Z","end":"2026-09-02T16:44:17.326635Z","steps":["trace[718537417] 'agreement among raft nodes before linearized reading' (duration: 177.452492ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:44:17.326596Z","caller":"traceutil/trace.go:171","msg":"trace[1097301196] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9054; }","duration":"157.390742ms","start":"2026-09-02T16:44:17.169188Z","end":"2026-09-02T16:44:17.326579Z","steps":["trace[1097301196] 'agreement among raft nodes before linearized reading' (duration: 157.185758ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:45:20.048407Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"cf809824ab95ac81","local-member-applied-index":10004,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-02T16:45:20.067332Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10004} {"level":"info","ts":"2026-09-02T16:45:20.068013Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5004} {"level":"info","ts":"2026-09-02T16:47:01.371013Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8053} {"level":"info","ts":"2026-09-02T16:47:01.452846Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8053,"took":"79.764726ms","hash":2902294933,"current-db-size-bytes":56946688,"current-db-size":"57 MB","current-db-size-in-use-bytes":28049408,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-02T16:47:01.452911Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2902294933,"revision":8053,"compact-revision":5842} {"level":"warn","ts":"2026-09-02T16:51:06.195117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.922238ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-02T16:51:06.195324Z","caller":"traceutil/trace.go:171","msg":"trace[51335522] transaction","detail":"{read_only:false; response_revision:12236; number_of_response:1; }","duration":"218.45999ms","start":"2026-09-02T16:51:05.976849Z","end":"2026-09-02T16:51:06.195309Z","steps":["trace[51335522] 'process raft request' (duration: 218.407389ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:51:06.195517Z","caller":"traceutil/trace.go:171","msg":"trace[200953838] transaction","detail":"{read_only:false; response_revision:12235; number_of_response:1; }","duration":"251.952937ms","start":"2026-09-02T16:51:05.943487Z","end":"2026-09-02T16:51:06.19544Z","steps":["trace[200953838] 'process raft request' (duration: 110.62626ms)","trace[200953838] 'compare' (duration: 140.812056ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:51:25.063233Z","caller":"traceutil/trace.go:171","msg":"trace[1130677669] transaction","detail":"{read_only:false; response_revision:12344; number_of_response:1; }","duration":"111.020988ms","start":"2026-09-02T16:51:24.952139Z","end":"2026-09-02T16:51:25.06316Z","steps":["trace[1130677669] 'process raft request' (duration: 106.648555ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:52:01.378888Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10416} {"level":"info","ts":"2026-09-02T16:52:01.470152Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10416,"took":"89.036438ms","hash":427991319,"current-db-size-bytes":56946688,"current-db-size":"57 MB","current-db-size-in-use-bytes":26402816,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-09-02T16:52:01.470221Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":427991319,"revision":10416,"compact-revision":8053} {"level":"info","ts":"2026-09-02T16:57:01.388488Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12589} {"level":"info","ts":"2026-09-02T16:57:01.475876Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12589,"took":"84.869674ms","hash":4089091556,"current-db-size-bytes":56946688,"current-db-size":"57 MB","current-db-size-in-use-bytes":27484160,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-02T16:57:01.475943Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4089091556,"revision":12589,"compact-revision":10416} {"level":"info","ts":"2026-09-02T16:58:05.878449Z","caller":"traceutil/trace.go:171","msg":"trace[1437986434] transaction","detail":"{read_only:false; response_revision:14999; number_of_response:1; }","duration":"111.959236ms","start":"2026-09-02T16:58:05.766462Z","end":"2026-09-02T16:58:05.878422Z","steps":["trace[1437986434] 'process raft request' (duration: 111.771612ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:58:23.607194Z","caller":"traceutil/trace.go:171","msg":"trace[1026355017] transaction","detail":"{read_only:false; response_revision:15104; number_of_response:1; }","duration":"355.615987ms","start":"2026-09-02T16:58:23.251552Z","end":"2026-09-02T16:58:23.607168Z","steps":["trace[1026355017] 'process raft request' (duration: 355.446634ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:58:23.607382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:58:23.251529Z","time spent":"355.740701ms","remote":"127.0.0.1:53116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12483,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-02T16:58:34.5188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.634193ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-02T16:58:34.518889Z","caller":"traceutil/trace.go:171","msg":"trace[1593514220] linearizableReadLoop","detail":"{readStateIndex:15804; appliedIndex:15803; }","duration":"302.805721ms","start":"2026-09-02T16:58:34.216071Z","end":"2026-09-02T16:58:34.518876Z","steps":["trace[1593514220] 'read index received' (duration: 170.952504ms)","trace[1593514220] 'applied index is now lower than readState.Index' (duration: 131.851467ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T16:58:34.518974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.900844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-02T16:58:34.518947Z","caller":"traceutil/trace.go:171","msg":"trace[1315622746] transaction","detail":"{read_only:false; response_revision:15275; number_of_response:1; }","duration":"315.478078ms","start":"2026-09-02T16:58:34.203416Z","end":"2026-09-02T16:58:34.518894Z","steps":["trace[1315622746] 'process raft request' (duration: 183.684812ms)","trace[1315622746] 'compare' (duration: 131.409498ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T16:58:34.518991Z","caller":"traceutil/trace.go:171","msg":"trace[403474359] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15275; }","duration":"302.957795ms","start":"2026-09-02T16:58:34.216027Z","end":"2026-09-02T16:58:34.518985Z","steps":["trace[403474359] 'agreement among raft nodes before linearized reading' (duration: 302.896494ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:58:34.51901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:58:34.216007Z","time spent":"302.998416ms","remote":"127.0.0.1:52906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-02T16:58:34.519062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:58:34.20339Z","time spent":"315.618322ms","remote":"127.0.0.1:52998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":854,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-02T16:58:34.558494Z","caller":"traceutil/trace.go:171","msg":"trace[1683203409] transaction","detail":"{read_only:false; response_revision:15277; number_of_response:1; }","duration":"272.866959ms","start":"2026-09-02T16:58:34.285596Z","end":"2026-09-02T16:58:34.558463Z","steps":["trace[1683203409] 'process raft request' (duration: 272.791747ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:58:34.55852Z","caller":"traceutil/trace.go:171","msg":"trace[840703936] transaction","detail":"{read_only:false; response_revision:15276; number_of_response:1; }","duration":"340.254244ms","start":"2026-09-02T16:58:34.218207Z","end":"2026-09-02T16:58:34.558461Z","steps":["trace[840703936] 'process raft request' (duration: 340.019709ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:58:34.558795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T16:58:34.21819Z","time spent":"340.466788ms","remote":"127.0.0.1:53178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-02T16:58:34.558836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.337821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-02T16:58:34.558893Z","caller":"traceutil/trace.go:171","msg":"trace[194452156] transaction","detail":"{read_only:false; response_revision:15278; number_of_response:1; }","duration":"260.948066ms","start":"2026-09-02T16:58:34.29791Z","end":"2026-09-02T16:58:34.558858Z","steps":["trace[194452156] 'process raft request' (duration: 260.516577ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:58:34.558927Z","caller":"traceutil/trace.go:171","msg":"trace[871839990] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/; range_end:/registry/monitoring.coreos.com/prometheuses0; response_count:0; response_revision:15278; }","duration":"188.476455ms","start":"2026-09-02T16:58:34.370433Z","end":"2026-09-02T16:58:34.558909Z","steps":["trace[871839990] 'agreement among raft nodes before linearized reading' (duration: 188.295211ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:58:34.558923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.318042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c074d429-93b9-434d-8f45-f3582becf8b8\" ","response":"range_response_count:1 size:3607"} {"level":"warn","ts":"2026-09-02T16:58:34.558949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.922775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-02T16:58:34.559025Z","caller":"traceutil/trace.go:171","msg":"trace[1465301430] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:15278; }","duration":"208.129129ms","start":"2026-09-02T16:58:34.350876Z","end":"2026-09-02T16:58:34.559005Z","steps":["trace[1465301430] 'agreement among raft nodes before linearized reading' (duration: 207.813742ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T16:58:34.559021Z","caller":"traceutil/trace.go:171","msg":"trace[791251180] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c074d429-93b9-434d-8f45-f3582becf8b8; range_end:; response_count:1; response_revision:15278; }","duration":"146.476256ms","start":"2026-09-02T16:58:34.41252Z","end":"2026-09-02T16:58:34.558996Z","steps":["trace[791251180] 'agreement among raft nodes before linearized reading' (duration: 146.155359ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T16:58:34.55885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.59008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-02T16:58:34.559143Z","caller":"traceutil/trace.go:171","msg":"trace[1599551304] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/; range_end:/registry/ceph.rook.io/cephclusters0; response_count:0; response_revision:15278; }","duration":"234.924416ms","start":"2026-09-02T16:58:34.324181Z","end":"2026-09-02T16:58:34.559105Z","steps":["trace[1599551304] 'agreement among raft nodes before linearized reading' (duration: 234.534148ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:00:16.105111Z","caller":"traceutil/trace.go:171","msg":"trace[227374865] transaction","detail":"{read_only:false; response_revision:16401; number_of_response:1; }","duration":"111.195518ms","start":"2026-09-02T17:00:15.993892Z","end":"2026-09-02T17:00:16.105088Z","steps":["trace[227374865] 'process raft request' (duration: 111.015564ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T17:00:16.385758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.989826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-02T17:00:16.385864Z","caller":"traceutil/trace.go:171","msg":"trace[210353073] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:16401; }","duration":"174.135699ms","start":"2026-09-02T17:00:16.211704Z","end":"2026-09-02T17:00:16.385839Z","steps":["trace[210353073] 'range keys from in-memory index tree' (duration: 173.925314ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:02:01.395363Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14586} {"level":"info","ts":"2026-09-02T17:02:01.492014Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14586,"took":"94.36974ms","hash":3639064422,"current-db-size-bytes":56946688,"current-db-size":"57 MB","current-db-size-in-use-bytes":31342592,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-09-02T17:02:01.492068Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3639064422,"revision":14586,"compact-revision":12589} {"level":"info","ts":"2026-09-02T17:05:57.220407Z","caller":"traceutil/trace.go:171","msg":"trace[2033015733] transaction","detail":"{read_only:false; response_revision:18882; number_of_response:1; }","duration":"122.388228ms","start":"2026-09-02T17:05:57.097966Z","end":"2026-09-02T17:05:57.220354Z","steps":["trace[2033015733] 'process raft request' (duration: 122.135252ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:05:57.320594Z","caller":"traceutil/trace.go:171","msg":"trace[127557560] linearizableReadLoop","detail":"{readStateIndex:19526; appliedIndex:19524; }","duration":"107.348778ms","start":"2026-09-02T17:05:57.213221Z","end":"2026-09-02T17:05:57.320569Z","steps":["trace[127557560] 'read index received' (duration: 6.837747ms)","trace[127557560] 'applied index is now lower than readState.Index' (duration: 100.510011ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T17:05:57.320734Z","caller":"traceutil/trace.go:171","msg":"trace[430701492] transaction","detail":"{read_only:false; response_revision:18883; number_of_response:1; }","duration":"220.083408ms","start":"2026-09-02T17:05:57.100608Z","end":"2026-09-02T17:05:57.320691Z","steps":["trace[430701492] 'process raft request' (duration: 171.816779ms)","trace[430701492] 'compare' (duration: 47.994683ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T17:05:57.320763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.570652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-02T17:05:57.320956Z","caller":"traceutil/trace.go:171","msg":"trace[539414499] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18883; }","duration":"107.802337ms","start":"2026-09-02T17:05:57.213125Z","end":"2026-09-02T17:05:57.320928Z","steps":["trace[539414499] 'agreement among raft nodes before linearized reading' (duration: 107.565112ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:05:58.530323Z","caller":"traceutil/trace.go:171","msg":"trace[1339552976] linearizableReadLoop","detail":"{readStateIndex:19530; appliedIndex:19529; }","duration":"143.710002ms","start":"2026-09-02T17:05:58.386584Z","end":"2026-09-02T17:05:58.530294Z","steps":["trace[1339552976] 'read index received' (duration: 143.507097ms)","trace[1339552976] 'applied index is now lower than readState.Index' (duration: 201.685µs)"],"step_count":2} {"level":"info","ts":"2026-09-02T17:05:58.530402Z","caller":"traceutil/trace.go:171","msg":"trace[810923712] transaction","detail":"{read_only:false; response_revision:18887; number_of_response:1; }","duration":"166.260082ms","start":"2026-09-02T17:05:58.364091Z","end":"2026-09-02T17:05:58.530351Z","steps":["trace[810923712] 'process raft request' (duration: 166.007876ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T17:05:58.530551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.947277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:702"} {"level":"info","ts":"2026-09-02T17:05:58.530626Z","caller":"traceutil/trace.go:171","msg":"trace[1757381652] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18887; }","duration":"144.076449ms","start":"2026-09-02T17:05:58.386533Z","end":"2026-09-02T17:05:58.530609Z","steps":["trace[1757381652] 'agreement among raft nodes before linearized reading' (duration: 143.858805ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:05:58.564393Z","caller":"traceutil/trace.go:171","msg":"trace[851367198] transaction","detail":"{read_only:false; response_revision:18888; number_of_response:1; }","duration":"135.506487ms","start":"2026-09-02T17:05:58.428862Z","end":"2026-09-02T17:05:58.564368Z","steps":["trace[851367198] 'process raft request' (duration: 135.304453ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T17:05:58.564442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.245041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-hmgz9\" ","response":"range_response_count:1 size:9792"} {"level":"info","ts":"2026-09-02T17:05:58.564494Z","caller":"traceutil/trace.go:171","msg":"trace[1172776176] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-hmgz9; range_end:; response_count:1; response_revision:18888; }","duration":"158.347784ms","start":"2026-09-02T17:05:58.406131Z","end":"2026-09-02T17:05:58.564479Z","steps":["trace[1172776176] 'agreement among raft nodes before linearized reading' (duration: 158.18492ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T17:06:07.267999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.168307ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-02T17:06:07.268303Z","caller":"traceutil/trace.go:171","msg":"trace[440652366] transaction","detail":"{read_only:false; response_revision:19013; number_of_response:1; }","duration":"121.53559ms","start":"2026-09-02T17:06:07.146754Z","end":"2026-09-02T17:06:07.26829Z","steps":["trace[440652366] 'process raft request' (duration: 121.476429ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:06:07.268296Z","caller":"traceutil/trace.go:171","msg":"trace[1743218608] transaction","detail":"{read_only:false; number_of_response:1; response_revision:19012; }","duration":"137.836466ms","start":"2026-09-02T17:06:07.130431Z","end":"2026-09-02T17:06:07.268268Z","steps":["trace[1743218608] 'process raft request' (duration: 137.641942ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:06:07.268467Z","caller":"traceutil/trace.go:171","msg":"trace[1992343152] transaction","detail":"{read_only:false; number_of_response:1; response_revision:19012; }","duration":"137.942258ms","start":"2026-09-02T17:06:07.130511Z","end":"2026-09-02T17:06:07.268453Z","steps":["trace[1992343152] 'process raft request' (duration: 137.586251ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:06:07.268488Z","caller":"traceutil/trace.go:171","msg":"trace[634699269] linearizableReadLoop","detail":"{readStateIndex:19662; appliedIndex:19658; }","duration":"137.243603ms","start":"2026-09-02T17:06:07.13119Z","end":"2026-09-02T17:06:07.268433Z","steps":["trace[634699269] 'read index received' (duration: 11.734149ms)","trace[634699269] 'applied index is now lower than readState.Index' (duration: 125.505844ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T17:06:07.268563Z","caller":"traceutil/trace.go:171","msg":"trace[2114099182] transaction","detail":"{read_only:false; response_revision:19012; number_of_response:1; }","duration":"138.189844ms","start":"2026-09-02T17:06:07.130305Z","end":"2026-09-02T17:06:07.268495Z","steps":["trace[2114099182] 'process raft request' (duration: 34.457365ms)","trace[2114099182] 'compare' (duration: 103.074735ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T17:06:07.268734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.519039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/openstack/libvirt-libvirt-default-hkx7q-vnc\" ","response":"range_response_count:1 size:1501"} {"level":"info","ts":"2026-09-02T17:06:07.268797Z","caller":"traceutil/trace.go:171","msg":"trace[1177818034] range","detail":"{range_begin:/registry/cert-manager.io/certificates/openstack/libvirt-libvirt-default-hkx7q-vnc; range_end:; response_count:1; response_revision:19013; }","duration":"137.628481ms","start":"2026-09-02T17:06:07.131149Z","end":"2026-09-02T17:06:07.268778Z","steps":["trace[1177818034] 'agreement among raft nodes before linearized reading' (duration: 137.466088ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T17:06:07.268857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.166126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-4z4wv\" ","response":"range_response_count:1 size:22094"} {"level":"info","ts":"2026-09-02T17:06:07.268902Z","caller":"traceutil/trace.go:171","msg":"trace[32363087] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-4z4wv; range_end:; response_count:1; response_revision:19013; }","duration":"117.247647ms","start":"2026-09-02T17:06:07.151644Z","end":"2026-09-02T17:06:07.268892Z","steps":["trace[32363087] 'agreement among raft nodes before linearized reading' (duration: 117.086144ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:06:38.706586Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"cf809824ab95ac81","local-member-applied-index":20005,"local-member-snapshot-index":10004,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-02T17:06:38.713715Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20005} {"level":"info","ts":"2026-09-02T17:06:38.713821Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15005} {"level":"info","ts":"2026-09-02T17:07:01.404011Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17074} {"level":"info","ts":"2026-09-02T17:07:01.521903Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17074,"took":"113.715113ms","hash":2112685618,"current-db-size-bytes":56946688,"current-db-size":"57 MB","current-db-size-in-use-bytes":33644544,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-09-02T17:07:01.521968Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2112685618,"revision":17074,"compact-revision":14586} {"level":"info","ts":"2026-09-02T17:12:01.41705Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19524} {"level":"info","ts":"2026-09-02T17:12:01.615569Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19524,"took":"194.501448ms","hash":542937703,"current-db-size-bytes":56946688,"current-db-size":"57 MB","current-db-size-in-use-bytes":30732288,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-09-02T17:12:01.615644Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":542937703,"revision":19524,"compact-revision":17074} {"level":"info","ts":"2026-09-02T17:12:46.636854Z","caller":"traceutil/trace.go:171","msg":"trace[1122333743] transaction","detail":"{read_only:false; response_revision:22007; number_of_response:1; }","duration":"345.736692ms","start":"2026-09-02T17:12:46.291093Z","end":"2026-09-02T17:12:46.63683Z","steps":["trace[1122333743] 'process raft request' (duration: 345.580238ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T17:12:46.637058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:12:46.291071Z","time spent":"345.860084ms","remote":"127.0.0.1:53178","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-09-02T17:12:46.803556Z","caller":"traceutil/trace.go:171","msg":"trace[1771456279] transaction","detail":"{read_only:false; response_revision:22008; number_of_response:1; }","duration":"447.312904ms","start":"2026-09-02T17:12:46.356193Z","end":"2026-09-02T17:12:46.803505Z","steps":["trace[1771456279] 'process raft request' (duration: 419.248654ms)","trace[1771456279] 'compare' (duration: 27.820735ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T17:12:46.803934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-02T17:12:46.356173Z","time spent":"447.509798ms","remote":"127.0.0.1:53178","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-09-02T17:12:47.081728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.913405ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-02T17:12:47.081844Z","caller":"traceutil/trace.go:171","msg":"trace[553283919] linearizableReadLoop","detail":"{readStateIndex:22760; appliedIndex:22759; }","duration":"182.155724ms","start":"2026-09-02T17:12:46.899666Z","end":"2026-09-02T17:12:47.081822Z","steps":["trace[553283919] 'read index received' (duration: 45.998914ms)","trace[553283919] 'applied index is now lower than readState.Index' (duration: 136.15538ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T17:12:47.081957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.282278ms","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-09-02T17:12:47.082136Z","caller":"traceutil/trace.go:171","msg":"trace[441714604] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:22009; }","duration":"182.446411ms","start":"2026-09-02T17:12:46.899624Z","end":"2026-09-02T17:12:47.082071Z","steps":["trace[441714604] 'agreement among raft nodes before linearized reading' (duration: 182.253376ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:12:47.081951Z","caller":"traceutil/trace.go:171","msg":"trace[602281386] transaction","detail":"{read_only:false; response_revision:22009; number_of_response:1; }","duration":"259.448076ms","start":"2026-09-02T17:12:46.822467Z","end":"2026-09-02T17:12:47.081915Z","steps":["trace[602281386] 'process raft request' (duration: 123.259225ms)","trace[602281386] 'compare' (duration: 135.64017ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T17:12:47.738818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.693255ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-02T17:12:47.738938Z","caller":"traceutil/trace.go:171","msg":"trace[1080558770] linearizableReadLoop","detail":"{readStateIndex:22762; appliedIndex:22761; }","duration":"146.943131ms","start":"2026-09-02T17:12:47.591975Z","end":"2026-09-02T17:12:47.738918Z","steps":["trace[1080558770] 'read index received' (duration: 994.031µs)","trace[1080558770] 'applied index is now lower than readState.Index' (duration: 145.94676ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T17:12:47.739076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.115334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-02T17:12:47.739034Z","caller":"traceutil/trace.go:171","msg":"trace[2135377168] transaction","detail":"{read_only:false; response_revision:22011; number_of_response:1; }","duration":"158.948868ms","start":"2026-09-02T17:12:47.58005Z","end":"2026-09-02T17:12:47.738998Z","steps":["trace[2135377168] 'process raft request' (duration: 12.980507ms)","trace[2135377168] 'compare' (duration: 145.46112ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T17:12:47.73913Z","caller":"traceutil/trace.go:171","msg":"trace[1737300752] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:22011; }","duration":"147.216156ms","start":"2026-09-02T17:12:47.591898Z","end":"2026-09-02T17:12:47.739115Z","steps":["trace[1737300752] 'agreement among raft nodes before linearized reading' (duration: 147.125194ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:12:47.879786Z","caller":"traceutil/trace.go:171","msg":"trace[256780796] transaction","detail":"{read_only:false; response_revision:22013; number_of_response:1; }","duration":"132.564364ms","start":"2026-09-02T17:12:47.747198Z","end":"2026-09-02T17:12:47.879762Z","steps":["trace[256780796] 'process raft request' (duration: 131.396729ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:13:23.581769Z","caller":"traceutil/trace.go:171","msg":"trace[1170535730] transaction","detail":"{read_only:false; response_revision:22367; number_of_response:1; }","duration":"100.834496ms","start":"2026-09-02T17:13:23.480907Z","end":"2026-09-02T17:13:23.581742Z","steps":["trace[1170535730] 'process raft request' (duration: 86.161282ms)","trace[1170535730] 'compare' (duration: 14.445689ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T17:13:23.581723Z","caller":"traceutil/trace.go:171","msg":"trace[1942232367] transaction","detail":"{read_only:false; response_revision:22368; number_of_response:1; }","duration":"100.610931ms","start":"2026-09-02T17:13:23.481083Z","end":"2026-09-02T17:13:23.581694Z","steps":["trace[1942232367] 'process raft request' (duration: 100.548399ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:13:23.854727Z","caller":"traceutil/trace.go:171","msg":"trace[85801561] transaction","detail":"{read_only:false; response_revision:22388; number_of_response:1; }","duration":"145.656133ms","start":"2026-09-02T17:13:23.709026Z","end":"2026-09-02T17:13:23.854682Z","steps":["trace[85801561] 'process raft request' (duration: 145.52286ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:13:23.854769Z","caller":"traceutil/trace.go:171","msg":"trace[2118924433] transaction","detail":"{read_only:false; response_revision:22389; number_of_response:1; }","duration":"145.713935ms","start":"2026-09-02T17:13:23.709024Z","end":"2026-09-02T17:13:23.854738Z","steps":["trace[2118924433] 'process raft request' (duration: 145.579033ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:13:23.854851Z","caller":"traceutil/trace.go:171","msg":"trace[2055661685] linearizableReadLoop","detail":"{readStateIndex:23160; appliedIndex:23155; }","duration":"109.766236ms","start":"2026-09-02T17:13:23.745057Z","end":"2026-09-02T17:13:23.854823Z","steps":["trace[2055661685] 'read index received' (duration: 74.334289ms)","trace[2055661685] 'applied index is now lower than readState.Index' (duration: 35.430777ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T17:13:23.854963Z","caller":"traceutil/trace.go:171","msg":"trace[65830725] transaction","detail":"{read_only:false; response_revision:22391; number_of_response:1; }","duration":"137.484709ms","start":"2026-09-02T17:13:23.717465Z","end":"2026-09-02T17:13:23.85495Z","steps":["trace[65830725] 'process raft request' (duration: 137.268084ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:13:23.855044Z","caller":"traceutil/trace.go:171","msg":"trace[1258410080] transaction","detail":"{read_only:false; response_revision:22387; number_of_response:1; }","duration":"146.826998ms","start":"2026-09-02T17:13:23.708192Z","end":"2026-09-02T17:13:23.855019Z","steps":["trace[1258410080] 'process raft request' (duration: 111.146656ms)","trace[1258410080] 'compare' (duration: 35.065829ms)"],"step_count":2} {"level":"warn","ts":"2026-09-02T17:13:23.855178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.440454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/octavia-worker\" ","response":"range_response_count:1 size:7641"} {"level":"info","ts":"2026-09-02T17:13:23.855244Z","caller":"traceutil/trace.go:171","msg":"trace[1674661711] transaction","detail":"{read_only:false; response_revision:22390; number_of_response:1; }","duration":"142.333762ms","start":"2026-09-02T17:13:23.712857Z","end":"2026-09-02T17:13:23.855191Z","steps":["trace[1674661711] 'process raft request' (duration: 141.812191ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:13:23.855251Z","caller":"traceutil/trace.go:171","msg":"trace[44254669] range","detail":"{range_begin:/registry/deployments/openstack/octavia-worker; range_end:; response_count:1; response_revision:22391; }","duration":"142.555427ms","start":"2026-09-02T17:13:23.712682Z","end":"2026-09-02T17:13:23.855238Z","steps":["trace[44254669] 'agreement among raft nodes before linearized reading' (duration: 142.332352ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T17:13:23.855303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.593266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3685"} {"level":"info","ts":"2026-09-02T17:13:23.855355Z","caller":"traceutil/trace.go:171","msg":"trace[1217517254] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:22391; }","duration":"155.688568ms","start":"2026-09-02T17:13:23.699651Z","end":"2026-09-02T17:13:23.85534Z","steps":["trace[1217517254] 'agreement among raft nodes before linearized reading' (duration: 155.459493ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:13:23.863026Z","caller":"traceutil/trace.go:171","msg":"trace[897579982] transaction","detail":"{read_only:false; response_revision:22393; number_of_response:1; }","duration":"111.444973ms","start":"2026-09-02T17:13:23.751553Z","end":"2026-09-02T17:13:23.862998Z","steps":["trace[897579982] 'process raft request' (duration: 111.3138ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:13:23.863317Z","caller":"traceutil/trace.go:171","msg":"trace[38703543] transaction","detail":"{read_only:false; response_revision:22394; number_of_response:1; }","duration":"111.159925ms","start":"2026-09-02T17:13:23.75214Z","end":"2026-09-02T17:13:23.8633Z","steps":["trace[38703543] 'process raft request' (duration: 110.820868ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:13:23.8635Z","caller":"traceutil/trace.go:171","msg":"trace[1078658632] transaction","detail":"{read_only:false; response_revision:22395; number_of_response:1; }","duration":"111.206377ms","start":"2026-09-02T17:13:23.752273Z","end":"2026-09-02T17:13:23.863479Z","steps":["trace[1078658632] 'process raft request' (duration: 110.955902ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:13:23.863663Z","caller":"traceutil/trace.go:171","msg":"trace[2009124806] transaction","detail":"{read_only:false; response_revision:22396; number_of_response:1; }","duration":"107.13056ms","start":"2026-09-02T17:13:23.756522Z","end":"2026-09-02T17:13:23.863652Z","steps":["trace[2009124806] 'process raft request' (duration: 106.804153ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:13:23.863669Z","caller":"traceutil/trace.go:171","msg":"trace[1720456042] transaction","detail":"{read_only:false; response_revision:22392; number_of_response:1; }","duration":"113.622618ms","start":"2026-09-02T17:13:23.75Z","end":"2026-09-02T17:13:23.863622Z","steps":["trace[1720456042] 'process raft request' (duration: 112.75623ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:13:23.863894Z","caller":"traceutil/trace.go:171","msg":"trace[316450191] transaction","detail":"{read_only:false; response_revision:22397; number_of_response:1; }","duration":"107.330614ms","start":"2026-09-02T17:13:23.756543Z","end":"2026-09-02T17:13:23.863873Z","steps":["trace[316450191] 'process raft request' (duration: 107.068879ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T17:13:23.863959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.076402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/octavia-housekeeping\" ","response":"range_response_count:1 size:7401"} {"level":"warn","ts":"2026-09-02T17:13:23.863946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.190887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-09-02T17:13:23.864067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.395106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/octavia-api\" ","response":"range_response_count:1 size:7772"} {"level":"info","ts":"2026-09-02T17:13:23.864091Z","caller":"traceutil/trace.go:171","msg":"trace[228467110] range","detail":"{range_begin:/registry/deployments/openstack/octavia-api; range_end:; response_count:1; response_revision:22397; }","duration":"107.444378ms","start":"2026-09-02T17:13:23.75664Z","end":"2026-09-02T17:13:23.864084Z","steps":["trace[228467110] 'agreement among raft nodes before linearized reading' (duration: 107.369646ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:13:23.864074Z","caller":"traceutil/trace.go:171","msg":"trace[2060942149] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1; range_end:; response_count:0; response_revision:22397; }","duration":"111.360711ms","start":"2026-09-02T17:13:23.752695Z","end":"2026-09-02T17:13:23.864056Z","steps":["trace[2060942149] 'agreement among raft nodes before linearized reading' (duration: 111.187007ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:13:23.863994Z","caller":"traceutil/trace.go:171","msg":"trace[1659331801] range","detail":"{range_begin:/registry/deployments/openstack/octavia-housekeeping; range_end:; response_count:1; response_revision:22397; }","duration":"109.149214ms","start":"2026-09-02T17:13:23.754834Z","end":"2026-09-02T17:13:23.863984Z","steps":["trace[1659331801] 'agreement among raft nodes before linearized reading' (duration: 109.00895ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:13:24.002521Z","caller":"traceutil/trace.go:171","msg":"trace[1681018535] transaction","detail":"{read_only:false; response_revision:22400; number_of_response:1; }","duration":"134.897454ms","start":"2026-09-02T17:13:23.867558Z","end":"2026-09-02T17:13:24.002455Z","steps":["trace[1681018535] 'process raft request' (duration: 110.464851ms)","trace[1681018535] 'compare' (duration: 23.998874ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T17:13:24.002618Z","caller":"traceutil/trace.go:171","msg":"trace[484577681] transaction","detail":"{read_only:false; response_revision:22402; number_of_response:1; }","duration":"133.299431ms","start":"2026-09-02T17:13:23.869292Z","end":"2026-09-02T17:13:24.002591Z","steps":["trace[484577681] 'process raft request' (duration: 133.019505ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:13:24.002745Z","caller":"traceutil/trace.go:171","msg":"trace[645121692] transaction","detail":"{read_only:false; response_revision:22401; number_of_response:1; }","duration":"134.403943ms","start":"2026-09-02T17:13:23.868311Z","end":"2026-09-02T17:13:24.002715Z","steps":["trace[645121692] 'process raft request' (duration: 133.868282ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:13:24.002889Z","caller":"traceutil/trace.go:171","msg":"trace[1224029393] transaction","detail":"{read_only:false; response_revision:22403; number_of_response:1; }","duration":"131.599653ms","start":"2026-09-02T17:13:23.871268Z","end":"2026-09-02T17:13:24.002868Z","steps":["trace[1224029393] 'process raft request' (duration: 131.114353ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:13:24.003733Z","caller":"traceutil/trace.go:171","msg":"trace[1334635666] transaction","detail":"{read_only:false; response_revision:22404; number_of_response:1; }","duration":"131.399529ms","start":"2026-09-02T17:13:23.872299Z","end":"2026-09-02T17:13:24.003699Z","steps":["trace[1334635666] 'process raft request' (duration: 130.50231ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:13:24.00412Z","caller":"traceutil/trace.go:171","msg":"trace[1525911287] transaction","detail":"{read_only:false; response_revision:22405; number_of_response:1; }","duration":"128.1728ms","start":"2026-09-02T17:13:23.87592Z","end":"2026-09-02T17:13:24.004093Z","steps":["trace[1525911287] 'process raft request' (duration: 127.368912ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:13:24.004979Z","caller":"traceutil/trace.go:171","msg":"trace[1719092785] transaction","detail":"{read_only:false; response_revision:22409; number_of_response:1; }","duration":"121.064707ms","start":"2026-09-02T17:13:23.883896Z","end":"2026-09-02T17:13:24.00496Z","steps":["trace[1719092785] 'process raft request' (duration: 120.995326ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:13:24.005254Z","caller":"traceutil/trace.go:171","msg":"trace[1333161861] transaction","detail":"{read_only:false; response_revision:22408; number_of_response:1; }","duration":"126.551715ms","start":"2026-09-02T17:13:23.878647Z","end":"2026-09-02T17:13:24.005199Z","steps":["trace[1333161861] 'process raft request' (duration: 126.167427ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:13:24.005493Z","caller":"traceutil/trace.go:171","msg":"trace[837166321] linearizableReadLoop","detail":"{readStateIndex:23177; appliedIndex:23168; }","duration":"125.861141ms","start":"2026-09-02T17:13:23.879615Z","end":"2026-09-02T17:13:24.005476Z","steps":["trace[837166321] 'read index received' (duration: 98.418274ms)","trace[837166321] 'applied index is now lower than readState.Index' (duration: 27.441107ms)"],"step_count":2} {"level":"info","ts":"2026-09-02T17:13:24.005858Z","caller":"traceutil/trace.go:171","msg":"trace[1564365081] transaction","detail":"{read_only:false; response_revision:22406; number_of_response:1; }","duration":"129.57596ms","start":"2026-09-02T17:13:23.876264Z","end":"2026-09-02T17:13:24.00584Z","steps":["trace[1564365081] 'process raft request' (duration: 127.099777ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:13:24.00628Z","caller":"traceutil/trace.go:171","msg":"trace[1647723621] transaction","detail":"{read_only:false; response_revision:22407; number_of_response:1; }","duration":"128.473096ms","start":"2026-09-02T17:13:23.877773Z","end":"2026-09-02T17:13:24.006246Z","steps":["trace[1647723621] 'process raft request' (duration: 126.950964ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T17:13:24.00654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.106402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/openstack/octavia-api-84b7cd9f98\" ","response":"range_response_count:1 size:7754"} {"level":"info","ts":"2026-09-02T17:13:24.007035Z","caller":"traceutil/trace.go:171","msg":"trace[1873376279] range","detail":"{range_begin:/registry/replicasets/openstack/octavia-api-84b7cd9f98; range_end:; response_count:1; response_revision:22409; }","duration":"131.641434ms","start":"2026-09-02T17:13:23.875374Z","end":"2026-09-02T17:13:24.007015Z","steps":["trace[1873376279] 'agreement among raft nodes before linearized reading' (duration: 130.99002ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T17:13:24.006551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.607309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:709"} {"level":"info","ts":"2026-09-02T17:13:24.007241Z","caller":"traceutil/trace.go:171","msg":"trace[656316630] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:22409; }","duration":"137.322845ms","start":"2026-09-02T17:13:23.869878Z","end":"2026-09-02T17:13:24.007201Z","steps":["trace[656316630] 'agreement among raft nodes before linearized reading' (duration: 136.515567ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T17:13:24.007632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.893347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-09-02T17:13:24.007694Z","caller":"traceutil/trace.go:171","msg":"trace[1711970748] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:22409; }","duration":"122.981319ms","start":"2026-09-02T17:13:23.884691Z","end":"2026-09-02T17:13:24.007672Z","steps":["trace[1711970748] 'agreement among raft nodes before linearized reading' (duration: 122.821486ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T17:17:01.30219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.158291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-02T17:17:01.302318Z","caller":"traceutil/trace.go:171","msg":"trace[1246651558] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24569; }","duration":"144.342635ms","start":"2026-09-02T17:17:01.157954Z","end":"2026-09-02T17:17:01.302297Z","steps":["trace[1246651558] 'range keys from in-memory index tree' (duration: 143.975468ms)"],"step_count":1} {"level":"warn","ts":"2026-09-02T17:17:01.302423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.85911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-09-02T17:17:01.3026Z","caller":"traceutil/trace.go:171","msg":"trace[1390863314] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24569; }","duration":"103.967192ms","start":"2026-09-02T17:17:01.198528Z","end":"2026-09-02T17:17:01.302496Z","steps":["trace[1390863314] 'range keys from in-memory index tree' (duration: 103.598965ms)"],"step_count":1} {"level":"info","ts":"2026-09-02T17:17:01.425984Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21776} {"level":"info","ts":"2026-09-02T17:17:01.553814Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21776,"took":"123.818227ms","hash":1365365611,"current-db-size-bytes":58314752,"current-db-size":"58 MB","current-db-size-in-use-bytes":42254336,"current-db-size-in-use":"42 MB"} {"level":"info","ts":"2026-09-02T17:17:01.553889Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1365365611,"revision":21776,"compact-revision":19524} {"level":"info","ts":"2026-09-02T17:20:16.587615Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006a4f.wal"} {"level":"info","ts":"2026-09-02T17:22:01.434733Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24576} {"level":"info","ts":"2026-09-02T17:22:01.602357Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24576,"took":"160.088268ms","hash":611195899,"current-db-size-bytes":58314752,"current-db-size":"58 MB","current-db-size-in-use-bytes":34086912,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-09-02T17:22:01.602443Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":611195899,"revision":24576,"compact-revision":21776} {"level":"info","ts":"2026-09-02T17:26:24.054467Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"cf809824ab95ac81","local-member-applied-index":30006,"local-member-snapshot-index":20005,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-02T17:26:24.058929Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30006} {"level":"info","ts":"2026-09-02T17:26:24.059008Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25006} {"level":"info","ts":"2026-09-02T17:27:01.443501Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27105} {"level":"info","ts":"2026-09-02T17:27:01.56829Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27105,"took":"120.665896ms","hash":1060391925,"current-db-size-bytes":58314752,"current-db-size":"58 MB","current-db-size-in-use-bytes":29650944,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-09-02T17:27:01.568384Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1060391925,"revision":27105,"compact-revision":24576}