{"level":"warn","ts":"2026-10-17T11:30:30.493013Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-17T11:30:30.493149Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.116: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.116:2380","--initial-cluster=instance=https://162.253.55.116:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.116:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.116:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-10-17T11:30:30.493264Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-17T11:30:30.493286Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.116:2380"]} {"level":"info","ts":"2026-10-17T11:30:30.493319Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-17T11:30:30.494489Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.116:2379"]} {"level":"info","ts":"2026-10-17T11:30:30.494708Z","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.116:2380"],"listen-peer-urls":["https://162.253.55.116:2380"],"advertise-client-urls":["https://162.253.55.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.116:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-10-17T11:30:30.500973Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.777199ms"} {"level":"info","ts":"2026-10-17T11:30:30.508502Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9755887b76c83964","cluster-id":"5ee78cd75a03071"} {"level":"info","ts":"2026-10-17T11:30:30.508647Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9755887b76c83964 switched to configuration voters=()"} {"level":"info","ts":"2026-10-17T11:30:30.508671Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9755887b76c83964 became follower at term 0"} {"level":"info","ts":"2026-10-17T11:30:30.508716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9755887b76c83964 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-17T11:30:30.508734Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9755887b76c83964 became follower at term 1"} {"level":"info","ts":"2026-10-17T11:30:30.508813Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9755887b76c83964 switched to configuration voters=(10904772136602712420)"} {"level":"warn","ts":"2026-10-17T11:30:30.52792Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-17T11:30:30.531879Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-17T11:30:30.542615Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-10-17T11:30:30.545624Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9755887b76c83964","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-17T11:30:30.545986Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9755887b76c83964","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-17T11:30:30.545981Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-17T11:30:30.546133Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-17T11:30:30.546173Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-17T11:30:30.547919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9755887b76c83964 switched to configuration voters=(10904772136602712420)"} {"level":"info","ts":"2026-10-17T11:30:30.548557Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5ee78cd75a03071","local-member-id":"9755887b76c83964","added-peer-id":"9755887b76c83964","added-peer-peer-urls":["https://162.253.55.116:2380"]} {"level":"info","ts":"2026-10-17T11:30:30.551135Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-17T11:30:30.551329Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.116:2380"} {"level":"info","ts":"2026-10-17T11:30:30.55143Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.116:2380"} {"level":"info","ts":"2026-10-17T11:30:30.551501Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9755887b76c83964","initial-advertise-peer-urls":["https://162.253.55.116:2380"],"listen-peer-urls":["https://162.253.55.116:2380"],"advertise-client-urls":["https://162.253.55.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-17T11:30:30.551567Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-17T11:30:31.309691Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9755887b76c83964 is starting a new election at term 1"} {"level":"info","ts":"2026-10-17T11:30:31.309778Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9755887b76c83964 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-17T11:30:31.309805Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9755887b76c83964 received MsgPreVoteResp from 9755887b76c83964 at term 1"} {"level":"info","ts":"2026-10-17T11:30:31.309825Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9755887b76c83964 became candidate at term 2"} {"level":"info","ts":"2026-10-17T11:30:31.309855Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9755887b76c83964 received MsgVoteResp from 9755887b76c83964 at term 2"} {"level":"info","ts":"2026-10-17T11:30:31.309871Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9755887b76c83964 became leader at term 2"} {"level":"info","ts":"2026-10-17T11:30:31.309885Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9755887b76c83964 elected leader 9755887b76c83964 at term 2"} {"level":"info","ts":"2026-10-17T11:30:31.31123Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T11:30:31.312513Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-17T11:30:31.31261Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-17T11:30:31.312513Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9755887b76c83964","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.116:2379]}","request-path":"/0/members/9755887b76c83964/attributes","cluster-id":"5ee78cd75a03071","publish-timeout":"7s"} {"level":"info","ts":"2026-10-17T11:30:31.312919Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-17T11:30:31.312973Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-17T11:30:31.313864Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5ee78cd75a03071","local-member-id":"9755887b76c83964","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T11:30:31.314009Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T11:30:31.31405Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T11:30:31.315354Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-17T11:30:31.319335Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.116:2379"} {"level":"warn","ts":"2026-10-17T11:31:20.776654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.676416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-t4xmp\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-10-17T11:31:20.776801Z","caller":"traceutil/trace.go:171","msg":"trace[1278064399] range","detail":"{range_begin:/registry/pods/kube-system/cilium-t4xmp; range_end:; response_count:1; response_revision:646; }","duration":"430.87182ms","start":"2026-10-17T11:31:20.345909Z","end":"2026-10-17T11:31:20.776781Z","steps":["trace[1278064399] 'range keys from in-memory index tree' (duration: 430.537782ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:31:20.776849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:31:20.345891Z","time spent":"430.944752ms","remote":"127.0.0.1:54002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-t4xmp\" "} {"level":"info","ts":"2026-10-17T11:31:20.958807Z","caller":"traceutil/trace.go:171","msg":"trace[2047887753] linearizableReadLoop","detail":"{readStateIndex:672; appliedIndex:671; }","duration":"271.706547ms","start":"2026-10-17T11:31:20.687075Z","end":"2026-10-17T11:31:20.958782Z","steps":["trace[2047887753] 'read index received' (duration: 270.830096ms)","trace[2047887753] 'applied index is now lower than readState.Index' (duration: 875.471µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:31:20.958912Z","caller":"traceutil/trace.go:171","msg":"trace[332616766] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"368.486949ms","start":"2026-10-17T11:31:20.590358Z","end":"2026-10-17T11:31:20.958845Z","steps":["trace[332616766] 'process raft request' (duration: 367.822164ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:31:20.95903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.936533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-17T11:31:20.959068Z","caller":"traceutil/trace.go:171","msg":"trace[271853937] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:647; }","duration":"272.025384ms","start":"2026-10-17T11:31:20.687033Z","end":"2026-10-17T11:31:20.959058Z","steps":["trace[271853937] 'agreement among raft nodes before linearized reading' (duration: 271.871851ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:31:20.959624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:31:20.590324Z","time spent":"368.671474ms","remote":"127.0.0.1:53928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:31:21.563673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.353227ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T11:31:21.56398Z","caller":"traceutil/trace.go:171","msg":"trace[1521562605] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:672; }","duration":"541.932809ms","start":"2026-10-17T11:31:21.022029Z","end":"2026-10-17T11:31:21.563962Z","steps":["trace[1521562605] 'read index received' (duration: 75.0752ms)","trace[1521562605] 'applied index is now lower than readState.Index' (duration: 466.856369ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:31:21.563997Z","caller":"traceutil/trace.go:171","msg":"trace[652166950] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"771.032792ms","start":"2026-10-17T11:31:20.79288Z","end":"2026-10-17T11:31:21.563913Z","steps":["trace[652166950] 'process raft request' (duration: 304.209374ms)","trace[652166950] 'compare' (duration: 466.234174ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:31:21.564022Z","caller":"traceutil/trace.go:171","msg":"trace[1942522219] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"600.707095ms","start":"2026-10-17T11:31:20.963277Z","end":"2026-10-17T11:31:21.563984Z","steps":["trace[1942522219] 'process raft request' (duration: 600.522321ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:31:21.564106Z","caller":"traceutil/trace.go:171","msg":"trace[1611083525] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"528.361389ms","start":"2026-10-17T11:31:21.035704Z","end":"2026-10-17T11:31:21.564066Z","steps":["trace[1611083525] 'process raft request' (duration: 528.196235ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:31:21.564133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:31:20.792834Z","time spent":"771.245057ms","remote":"127.0.0.1:54002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:31:21.564175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:31:20.963252Z","time spent":"600.841079ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:31:21.564245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:31:21.035688Z","time spent":"528.496693ms","remote":"127.0.0.1:54348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-17T11:31:21.56431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.266147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-10-17T11:31:21.564375Z","caller":"traceutil/trace.go:171","msg":"trace[748107365] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:650; }","duration":"542.356159ms","start":"2026-10-17T11:31:21.021998Z","end":"2026-10-17T11:31:21.564354Z","steps":["trace[748107365] 'agreement among raft nodes before linearized reading' (duration: 542.195605ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:31:21.565169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:31:21.02198Z","time spent":"543.151848ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-17T11:31:21.564429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.319156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:31:21.565276Z","caller":"traceutil/trace.go:171","msg":"trace[961950970] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:650; }","duration":"400.193047ms","start":"2026-10-17T11:31:21.165065Z","end":"2026-10-17T11:31:21.565258Z","steps":["trace[961950970] 'agreement among raft nodes before linearized reading' (duration: 399.318446ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:31:21.565336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:31:21.165051Z","time spent":"400.258298ms","remote":"127.0.0.1:53786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-17T11:31:37.44194Z","caller":"traceutil/trace.go:171","msg":"trace[2057104359] linearizableReadLoop","detail":"{readStateIndex:845; appliedIndex:844; }","duration":"278.133959ms","start":"2026-10-17T11:31:37.163783Z","end":"2026-10-17T11:31:37.441917Z","steps":["trace[2057104359] 'read index received' (duration: 277.963495ms)","trace[2057104359] 'applied index is now lower than readState.Index' (duration: 169.584µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:31:37.442028Z","caller":"traceutil/trace.go:171","msg":"trace[2014831775] transaction","detail":"{read_only:false; response_revision:814; number_of_response:1; }","duration":"324.048231ms","start":"2026-10-17T11:31:37.117941Z","end":"2026-10-17T11:31:37.44199Z","steps":["trace[2014831775] 'process raft request' (duration: 323.807606ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:31:37.442105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.287512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:31:37.442149Z","caller":"traceutil/trace.go:171","msg":"trace[148998177] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:814; }","duration":"278.385355ms","start":"2026-10-17T11:31:37.16375Z","end":"2026-10-17T11:31:37.442136Z","steps":["trace[148998177] 'agreement among raft nodes before linearized reading' (duration: 278.290233ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:31:37.442326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:31:37.117921Z","time spent":"324.186105ms","remote":"127.0.0.1:53996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4952,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:32:57.646707Z","caller":"traceutil/trace.go:171","msg":"trace[780235742] linearizableReadLoop","detail":"{readStateIndex:1975; appliedIndex:1974; }","duration":"253.324256ms","start":"2026-10-17T11:32:57.393354Z","end":"2026-10-17T11:32:57.646678Z","steps":["trace[780235742] 'read index received' (duration: 253.290335ms)","trace[780235742] 'applied index is now lower than readState.Index' (duration: 32.581µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:32:57.646818Z","caller":"traceutil/trace.go:171","msg":"trace[1334481925] transaction","detail":"{read_only:false; response_revision:1901; number_of_response:1; }","duration":"426.688049ms","start":"2026-10-17T11:32:57.220088Z","end":"2026-10-17T11:32:57.646776Z","steps":["trace[1334481925] 'process raft request' (duration: 426.410582ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:32:57.647017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.631734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-10-17T11:32:57.647043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:32:57.220056Z","time spent":"426.862013ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:32:57.647072Z","caller":"traceutil/trace.go:171","msg":"trace[659027303] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1901; }","duration":"253.760617ms","start":"2026-10-17T11:32:57.393296Z","end":"2026-10-17T11:32:57.647057Z","steps":["trace[659027303] 'agreement among raft nodes before linearized reading' (duration: 253.510041ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:32:57.680531Z","caller":"traceutil/trace.go:171","msg":"trace[1359828278] transaction","detail":"{read_only:false; response_revision:1902; number_of_response:1; }","duration":"236.549183ms","start":"2026-10-17T11:32:57.443952Z","end":"2026-10-17T11:32:57.680501Z","steps":["trace[1359828278] 'process raft request' (duration: 223.795625ms)","trace[1359828278] 'compare' (duration: 12.621855ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:32:58.064289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.287266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cd846da4-1799-41a3-9f27-5863ca682294\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-10-17T11:32:58.064386Z","caller":"traceutil/trace.go:171","msg":"trace[1937493878] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cd846da4-1799-41a3-9f27-5863ca682294; range_end:; response_count:1; response_revision:1903; }","duration":"189.435489ms","start":"2026-10-17T11:32:57.874927Z","end":"2026-10-17T11:32:58.064363Z","steps":["trace[1937493878] 'range keys from in-memory index tree' (duration: 189.113272ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:32:58.064428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.504745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cd846da4-1799-41a3-9f27-5863ca682294\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-10-17T11:32:58.06518Z","caller":"traceutil/trace.go:171","msg":"trace[1829697164] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cd846da4-1799-41a3-9f27-5863ca682294; range_end:; response_count:1; response_revision:1903; }","duration":"136.330965ms","start":"2026-10-17T11:32:57.928807Z","end":"2026-10-17T11:32:58.065138Z","steps":["trace[1829697164] 'range keys from in-memory index tree' (duration: 135.261089ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:33:11.062615Z","caller":"traceutil/trace.go:171","msg":"trace[471595362] transaction","detail":"{read_only:false; response_revision:2010; number_of_response:1; }","duration":"154.892049ms","start":"2026-10-17T11:33:10.907694Z","end":"2026-10-17T11:33:11.062586Z","steps":["trace[471595362] 'process raft request' (duration: 154.663983ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:33:42.578353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.981612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-17T11:33:42.578437Z","caller":"traceutil/trace.go:171","msg":"trace[2003600599] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:2199; }","duration":"105.113995ms","start":"2026-10-17T11:33:42.473306Z","end":"2026-10-17T11:33:42.57842Z","steps":["trace[2003600599] 'count revisions from in-memory index tree' (duration: 104.861328ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:33:48.02802Z","caller":"traceutil/trace.go:171","msg":"trace[329307823] transaction","detail":"{read_only:false; response_revision:2227; number_of_response:1; }","duration":"137.740953ms","start":"2026-10-17T11:33:47.890233Z","end":"2026-10-17T11:33:48.027974Z","steps":["trace[329307823] 'process raft request' (duration: 131.642931ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:33:48.394014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.21818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:33:48.394114Z","caller":"traceutil/trace.go:171","msg":"trace[929544140] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2228; }","duration":"229.365453ms","start":"2026-10-17T11:33:48.164727Z","end":"2026-10-17T11:33:48.394093Z","steps":["trace[929544140] 'range keys from in-memory index tree' (duration: 229.095037ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:33:49.041007Z","caller":"traceutil/trace.go:171","msg":"trace[1378069265] linearizableReadLoop","detail":"{readStateIndex:2319; appliedIndex:2317; }","duration":"382.231038ms","start":"2026-10-17T11:33:48.658758Z","end":"2026-10-17T11:33:49.04099Z","steps":["trace[1378069265] 'read index received' (duration: 32.105257ms)","trace[1378069265] 'applied index is now lower than readState.Index' (duration: 350.125011ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:33:49.041201Z","caller":"traceutil/trace.go:171","msg":"trace[1426156676] transaction","detail":"{read_only:false; response_revision:2233; number_of_response:1; }","duration":"445.462498ms","start":"2026-10-17T11:33:48.595726Z","end":"2026-10-17T11:33:49.041188Z","steps":["trace[1426156676] 'process raft request' (duration: 445.159861ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:33:49.041286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:33:48.595693Z","time spent":"445.53651ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:33:49.04127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.483724ms","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-10-17T11:33:49.041354Z","caller":"traceutil/trace.go:171","msg":"trace[1124395656] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2233; }","duration":"382.613947ms","start":"2026-10-17T11:33:48.658722Z","end":"2026-10-17T11:33:49.041336Z","steps":["trace[1124395656] 'agreement among raft nodes before linearized reading' (duration: 382.363161ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:33:49.041485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:33:48.658709Z","time spent":"382.76278ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-10-17T11:33:54.568417Z","caller":"traceutil/trace.go:171","msg":"trace[1484533659] linearizableReadLoop","detail":"{readStateIndex:2346; appliedIndex:2345; }","duration":"131.58233ms","start":"2026-10-17T11:33:54.436804Z","end":"2026-10-17T11:33:54.568386Z","steps":["trace[1484533659] 'read index received' (duration: 131.267982ms)","trace[1484533659] 'applied index is now lower than readState.Index' (duration: 313.158µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:33:54.568534Z","caller":"traceutil/trace.go:171","msg":"trace[1641999585] transaction","detail":"{read_only:false; response_revision:2259; number_of_response:1; }","duration":"132.48359ms","start":"2026-10-17T11:33:54.436009Z","end":"2026-10-17T11:33:54.568493Z","steps":["trace[1641999585] 'process raft request' (duration: 132.183603ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:33:54.568683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.112179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-10-17T11:33:54.568728Z","caller":"traceutil/trace.go:171","msg":"trace[290114091] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2259; }","duration":"131.1952ms","start":"2026-10-17T11:33:54.43752Z","end":"2026-10-17T11:33:54.568715Z","steps":["trace[290114091] 'agreement among raft nodes before linearized reading' (duration: 131.036867ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:33:54.568686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.868706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-10-17T11:33:54.568929Z","caller":"traceutil/trace.go:171","msg":"trace[19096588] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2259; }","duration":"132.05676ms","start":"2026-10-17T11:33:54.436743Z","end":"2026-10-17T11:33:54.5688Z","steps":["trace[19096588] 'agreement among raft nodes before linearized reading' (duration: 131.786344ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:35:17.113885Z","caller":"traceutil/trace.go:171","msg":"trace[990921732] linearizableReadLoop","detail":"{readStateIndex:3009; appliedIndex:3008; }","duration":"115.24261ms","start":"2026-10-17T11:35:16.99862Z","end":"2026-10-17T11:35:17.113863Z","steps":["trace[990921732] 'read index received' (duration: 115.062546ms)","trace[990921732] 'applied index is now lower than readState.Index' (duration: 179.234µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:35:17.113956Z","caller":"traceutil/trace.go:171","msg":"trace[1176013732] transaction","detail":"{read_only:false; response_revision:2897; number_of_response:1; }","duration":"145.878139ms","start":"2026-10-17T11:35:16.968044Z","end":"2026-10-17T11:35:17.113923Z","steps":["trace[1176013732] 'process raft request' (duration: 145.681035ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:35:17.114098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.459225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-17T11:35:17.114138Z","caller":"traceutil/trace.go:171","msg":"trace[1471770228] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2897; }","duration":"115.551407ms","start":"2026-10-17T11:35:16.998577Z","end":"2026-10-17T11:35:17.114128Z","steps":["trace[1471770228] 'agreement among raft nodes before linearized reading' (duration: 115.412354ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:35:17.114128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.987305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:35:17.114197Z","caller":"traceutil/trace.go:171","msg":"trace[440635378] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2897; }","duration":"109.117127ms","start":"2026-10-17T11:35:17.005062Z","end":"2026-10-17T11:35:17.114179Z","steps":["trace[440635378] 'agreement among raft nodes before linearized reading' (duration: 108.985364ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:35:17.702432Z","caller":"traceutil/trace.go:171","msg":"trace[1876836337] linearizableReadLoop","detail":"{readStateIndex:3012; appliedIndex:3011; }","duration":"175.324422ms","start":"2026-10-17T11:35:17.527084Z","end":"2026-10-17T11:35:17.702408Z","steps":["trace[1876836337] 'read index received' (duration: 175.166208ms)","trace[1876836337] 'applied index is now lower than readState.Index' (duration: 156.994µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:35:17.702493Z","caller":"traceutil/trace.go:171","msg":"trace[94144585] transaction","detail":"{read_only:false; response_revision:2900; number_of_response:1; }","duration":"335.084063ms","start":"2026-10-17T11:35:17.367372Z","end":"2026-10-17T11:35:17.702456Z","steps":["trace[94144585] 'process raft request' (duration: 334.876408ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:35:17.702673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:35:17.367347Z","time spent":"335.236307ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:35:17.702718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.635069ms","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-10-17T11:35:17.702999Z","caller":"traceutil/trace.go:171","msg":"trace[1000903393] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2900; }","duration":"175.947566ms","start":"2026-10-17T11:35:17.527027Z","end":"2026-10-17T11:35:17.702975Z","steps":["trace[1000903393] 'agreement among raft nodes before linearized reading' (duration: 175.494455ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:35:17.712919Z","caller":"traceutil/trace.go:171","msg":"trace[1661995050] transaction","detail":"{read_only:false; response_revision:2901; number_of_response:1; }","duration":"111.590016ms","start":"2026-10-17T11:35:17.601311Z","end":"2026-10-17T11:35:17.712901Z","steps":["trace[1661995050] 'process raft request' (duration: 111.459543ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:38:24.562633Z","caller":"traceutil/trace.go:171","msg":"trace[468231574] transaction","detail":"{read_only:false; response_revision:4085; number_of_response:1; }","duration":"205.181282ms","start":"2026-10-17T11:38:24.357426Z","end":"2026-10-17T11:38:24.562607Z","steps":["trace[468231574] 'process raft request' (duration: 205.025718ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:38:24.700627Z","caller":"traceutil/trace.go:171","msg":"trace[905378879] linearizableReadLoop","detail":"{readStateIndex:4242; appliedIndex:4240; }","duration":"197.886021ms","start":"2026-10-17T11:38:24.502719Z","end":"2026-10-17T11:38:24.700605Z","steps":["trace[905378879] 'read index received' (duration: 59.788932ms)","trace[905378879] 'applied index is now lower than readState.Index' (duration: 138.096179ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:38:24.700703Z","caller":"traceutil/trace.go:171","msg":"trace[896195550] transaction","detail":"{read_only:false; response_revision:4086; number_of_response:1; }","duration":"333.722237ms","start":"2026-10-17T11:38:24.366955Z","end":"2026-10-17T11:38:24.700677Z","steps":["trace[896195550] 'process raft request' (duration: 326.512998ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:38:24.700824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.096825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.116\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-10-17T11:38:24.700856Z","caller":"traceutil/trace.go:171","msg":"trace[478733260] range","detail":"{range_begin:/registry/masterleases/162.253.55.116; range_end:; response_count:1; response_revision:4086; }","duration":"198.182808ms","start":"2026-10-17T11:38:24.502664Z","end":"2026-10-17T11:38:24.700847Z","steps":["trace[478733260] 'agreement among raft nodes before linearized reading' (duration: 198.052725ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:38:24.700895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:38:24.366931Z","time spent":"333.832359ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:38:24.700916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.891336ms","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-10-17T11:38:24.700994Z","caller":"traceutil/trace.go:171","msg":"trace[1717639332] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4086; }","duration":"121.015078ms","start":"2026-10-17T11:38:24.579961Z","end":"2026-10-17T11:38:24.700976Z","steps":["trace[1717639332] 'agreement among raft nodes before linearized reading' (duration: 120.816403ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:39:49.3487Z","caller":"traceutil/trace.go:171","msg":"trace[519947374] transaction","detail":"{read_only:false; response_revision:5140; number_of_response:1; }","duration":"108.158133ms","start":"2026-10-17T11:39:49.240508Z","end":"2026-10-17T11:39:49.348666Z","steps":["trace[519947374] 'process raft request' (duration: 107.908248ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:39:49.586512Z","caller":"traceutil/trace.go:171","msg":"trace[1861330516] transaction","detail":"{read_only:false; response_revision:5141; number_of_response:1; }","duration":"144.448743ms","start":"2026-10-17T11:39:49.44204Z","end":"2026-10-17T11:39:49.586488Z","steps":["trace[1861330516] 'process raft request' (duration: 144.273839ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:39:49.720057Z","caller":"traceutil/trace.go:171","msg":"trace[1912921630] transaction","detail":"{read_only:false; response_revision:5144; number_of_response:1; }","duration":"126.042672ms","start":"2026-10-17T11:39:49.593986Z","end":"2026-10-17T11:39:49.720029Z","steps":["trace[1912921630] 'process raft request' (duration: 125.898458ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:39:49.720068Z","caller":"traceutil/trace.go:171","msg":"trace[490034621] transaction","detail":"{read_only:false; response_revision:5143; number_of_response:1; }","duration":"127.350143ms","start":"2026-10-17T11:39:49.592682Z","end":"2026-10-17T11:39:49.720032Z","steps":["trace[490034621] 'process raft request' (duration: 121.149708ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:39:52.825495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.108724ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T11:39:52.8256Z","caller":"traceutil/trace.go:171","msg":"trace[902040494] linearizableReadLoop","detail":"{readStateIndex:5461; appliedIndex:5460; }","duration":"331.463803ms","start":"2026-10-17T11:39:52.49412Z","end":"2026-10-17T11:39:52.825584Z","steps":["trace[902040494] 'read index received' (duration: 205.179356ms)","trace[902040494] 'applied index is now lower than readState.Index' (duration: 126.283177ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:39:52.825665Z","caller":"traceutil/trace.go:171","msg":"trace[2058537262] transaction","detail":"{read_only:false; response_revision:5261; number_of_response:1; }","duration":"332.481697ms","start":"2026-10-17T11:39:52.493153Z","end":"2026-10-17T11:39:52.825635Z","steps":["trace[2058537262] 'process raft request' (duration: 206.149068ms)","trace[2058537262] 'compare' (duration: 125.838447ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:39:52.825791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.666778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-10-17T11:39:52.825814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:39:52.493132Z","time spent":"332.60553ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:39:52.825827Z","caller":"traceutil/trace.go:171","msg":"trace[1123309799] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5261; }","duration":"331.725949ms","start":"2026-10-17T11:39:52.494092Z","end":"2026-10-17T11:39:52.825817Z","steps":["trace[1123309799] 'agreement among raft nodes before linearized reading' (duration: 331.576745ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:39:52.825862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:39:52.49408Z","time spent":"331.774771ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-17T11:39:52.826023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.482056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-10-17T11:39:52.826052Z","caller":"traceutil/trace.go:171","msg":"trace[126571150] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5261; }","duration":"329.730512ms","start":"2026-10-17T11:39:52.496314Z","end":"2026-10-17T11:39:52.826045Z","steps":["trace[126571150] 'agreement among raft nodes before linearized reading' (duration: 329.65651ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:39:52.826082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:39:52.496304Z","time spent":"329.767334ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-17T11:39:52.826401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.450542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-84616d95-2579-4154-b933-1ca00cdf8a1a\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-10-17T11:39:52.826477Z","caller":"traceutil/trace.go:171","msg":"trace[220303607] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-84616d95-2579-4154-b933-1ca00cdf8a1a; range_end:; response_count:1; response_revision:5261; }","duration":"205.560145ms","start":"2026-10-17T11:39:52.620899Z","end":"2026-10-17T11:39:52.82646Z","steps":["trace[220303607] 'agreement among raft nodes before linearized reading' (duration: 205.318849ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:39:55.310546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.00281ms","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-10-17T11:39:55.310639Z","caller":"traceutil/trace.go:171","msg":"trace[233516608] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5305; }","duration":"155.137584ms","start":"2026-10-17T11:39:55.155479Z","end":"2026-10-17T11:39:55.310616Z","steps":["trace[233516608] 'range keys from in-memory index tree' (duration: 154.657493ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:39:55.310731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.210964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:39:55.311156Z","caller":"traceutil/trace.go:171","msg":"trace[1200267749] transaction","detail":"{read_only:false; response_revision:5306; number_of_response:1; }","duration":"109.371022ms","start":"2026-10-17T11:39:55.201766Z","end":"2026-10-17T11:39:55.311137Z","steps":["trace[1200267749] 'process raft request' (duration: 109.250579ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:39:55.311173Z","caller":"traceutil/trace.go:171","msg":"trace[713143752] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5305; }","duration":"146.923031ms","start":"2026-10-17T11:39:55.164226Z","end":"2026-10-17T11:39:55.311149Z","steps":["trace[713143752] 'range keys from in-memory index tree' (duration: 146.032691ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:40:08.135196Z","caller":"traceutil/trace.go:171","msg":"trace[1115402436] linearizableReadLoop","detail":"{readStateIndex:5753; appliedIndex:5752; }","duration":"126.41753ms","start":"2026-10-17T11:40:08.008757Z","end":"2026-10-17T11:40:08.135175Z","steps":["trace[1115402436] 'read index received' (duration: 126.200805ms)","trace[1115402436] 'applied index is now lower than readState.Index' (duration: 215.775µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:40:08.135266Z","caller":"traceutil/trace.go:171","msg":"trace[130886134] transaction","detail":"{read_only:false; response_revision:5543; number_of_response:1; }","duration":"156.512375ms","start":"2026-10-17T11:40:07.978715Z","end":"2026-10-17T11:40:08.135228Z","steps":["trace[130886134] 'process raft request' (duration: 156.319991ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:40:08.135531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.756619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-10-17T11:40:08.135615Z","caller":"traceutil/trace.go:171","msg":"trace[851719883] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5543; }","duration":"126.890882ms","start":"2026-10-17T11:40:08.008707Z","end":"2026-10-17T11:40:08.135598Z","steps":["trace[851719883] 'agreement among raft nodes before linearized reading' (duration: 126.607235ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:40:08.394304Z","caller":"traceutil/trace.go:171","msg":"trace[2001982848] transaction","detail":"{read_only:false; response_revision:5544; number_of_response:1; }","duration":"254.524142ms","start":"2026-10-17T11:40:08.139755Z","end":"2026-10-17T11:40:08.394279Z","steps":["trace[2001982848] 'process raft request' (duration: 251.735466ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:40:08.396707Z","caller":"traceutil/trace.go:171","msg":"trace[1171772854] linearizableReadLoop","detail":"{readStateIndex:5755; appliedIndex:5753; }","duration":"232.407603ms","start":"2026-10-17T11:40:08.16427Z","end":"2026-10-17T11:40:08.396678Z","steps":["trace[1171772854] 'read index received' (duration: 227.233062ms)","trace[1171772854] 'applied index is now lower than readState.Index' (duration: 5.173781ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:40:08.396826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.510036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:40:08.397025Z","caller":"traceutil/trace.go:171","msg":"trace[1013881086] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5545; }","duration":"232.777072ms","start":"2026-10-17T11:40:08.164225Z","end":"2026-10-17T11:40:08.397002Z","steps":["trace[1013881086] 'agreement among raft nodes before linearized reading' (duration: 232.524566ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:40:08.396954Z","caller":"traceutil/trace.go:171","msg":"trace[772802704] transaction","detail":"{read_only:false; response_revision:5545; number_of_response:1; }","duration":"249.008332ms","start":"2026-10-17T11:40:08.147931Z","end":"2026-10-17T11:40:08.396939Z","steps":["trace[772802704] 'process raft request' (duration: 248.663624ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:40:15.814215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.457389ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T11:40:15.814476Z","caller":"traceutil/trace.go:171","msg":"trace[412942376] transaction","detail":"{read_only:false; response_revision:5726; number_of_response:1; }","duration":"344.683373ms","start":"2026-10-17T11:40:15.469754Z","end":"2026-10-17T11:40:15.814437Z","steps":["trace[412942376] 'process raft request' (duration: 177.912527ms)","trace[412942376] 'compare' (duration: 166.264514ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:40:15.814564Z","caller":"traceutil/trace.go:171","msg":"trace[1254773096] linearizableReadLoop","detail":"{readStateIndex:5943; appliedIndex:5940; }","duration":"231.032381ms","start":"2026-10-17T11:40:15.583515Z","end":"2026-10-17T11:40:15.814547Z","steps":["trace[1254773096] 'read index received' (duration: 64.228654ms)","trace[1254773096] 'applied index is now lower than readState.Index' (duration: 166.802787ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:40:15.814638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:40:15.469737Z","time spent":"344.818196ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:40:15.814716Z","caller":"traceutil/trace.go:171","msg":"trace[519367875] transaction","detail":"{read_only:false; response_revision:5729; number_of_response:1; }","duration":"225.01657ms","start":"2026-10-17T11:40:15.58967Z","end":"2026-10-17T11:40:15.814686Z","steps":["trace[519367875] 'process raft request' (duration: 224.800495ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:40:15.814778Z","caller":"traceutil/trace.go:171","msg":"trace[1814947963] transaction","detail":"{read_only:false; response_revision:5727; number_of_response:1; }","duration":"327.883259ms","start":"2026-10-17T11:40:15.486883Z","end":"2026-10-17T11:40:15.814766Z","steps":["trace[1814947963] 'process raft request' (duration: 327.448589ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:40:15.814823Z","caller":"traceutil/trace.go:171","msg":"trace[1835184690] transaction","detail":"{read_only:false; response_revision:5728; number_of_response:1; }","duration":"312.98829ms","start":"2026-10-17T11:40:15.501825Z","end":"2026-10-17T11:40:15.814813Z","steps":["trace[1835184690] 'process raft request' (duration: 312.612481ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:40:15.815273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:40:15.486851Z","time spent":"328.33869ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:40:15.814911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.40954ms","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-10-17T11:40:15.815483Z","caller":"traceutil/trace.go:171","msg":"trace[652129749] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5729; }","duration":"232.011484ms","start":"2026-10-17T11:40:15.583452Z","end":"2026-10-17T11:40:15.815464Z","steps":["trace[652129749] 'agreement among raft nodes before linearized reading' (duration: 231.375599ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:40:15.815022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.100604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3195ad81-829c-4a3a-8e48-12ed914458c1\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-10-17T11:40:15.815593Z","caller":"traceutil/trace.go:171","msg":"trace[2112615294] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-3195ad81-829c-4a3a-8e48-12ed914458c1; range_end:; response_count:1; response_revision:5729; }","duration":"217.681419ms","start":"2026-10-17T11:40:15.597894Z","end":"2026-10-17T11:40:15.815575Z","steps":["trace[2112615294] 'agreement among raft nodes before linearized reading' (duration: 216.987423ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:40:15.815419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:40:15.501808Z","time spent":"313.513443ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:40:29.129591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.095043ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T11:40:29.1299Z","caller":"traceutil/trace.go:171","msg":"trace[1328916140] transaction","detail":"{read_only:false; response_revision:5859; number_of_response:1; }","duration":"615.352032ms","start":"2026-10-17T11:40:28.514528Z","end":"2026-10-17T11:40:29.12988Z","steps":["trace[1328916140] 'process raft request' (duration: 67.87461ms)","trace[1328916140] 'compare' (duration: 546.842337ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:40:29.129979Z","caller":"traceutil/trace.go:171","msg":"trace[1047701349] transaction","detail":"{read_only:false; response_revision:5860; number_of_response:1; }","duration":"102.760116ms","start":"2026-10-17T11:40:29.027183Z","end":"2026-10-17T11:40:29.129944Z","steps":["trace[1047701349] 'process raft request' (duration: 102.530561ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:40:29.130003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:40:28.51448Z","time spent":"615.468655ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:40:29.130053Z","caller":"traceutil/trace.go:171","msg":"trace[520733545] linearizableReadLoop","detail":"{readStateIndex:6076; appliedIndex:6075; }","duration":"122.003017ms","start":"2026-10-17T11:40:29.008027Z","end":"2026-10-17T11:40:29.13003Z","steps":["trace[520733545] 'read index received' (duration: 38.501µs)","trace[520733545] 'applied index is now lower than readState.Index' (duration: 121.963216ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:40:29.130274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.237663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-17T11:40:29.130338Z","caller":"traceutil/trace.go:171","msg":"trace[1715394462] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5860; }","duration":"122.303824ms","start":"2026-10-17T11:40:29.008015Z","end":"2026-10-17T11:40:29.130319Z","steps":["trace[1715394462] 'agreement among raft nodes before linearized reading' (duration: 122.11725ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:40:31.348107Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2977} {"level":"info","ts":"2026-10-17T11:40:31.42877Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2977,"took":"79.108223ms","hash":1773305755,"current-db-size-bytes":56479744,"current-db-size":"56 MB","current-db-size-in-use-bytes":32210944,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-17T11:40:31.428851Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1773305755,"revision":2977,"compact-revision":-1} {"level":"info","ts":"2026-10-17T11:41:08.036893Z","caller":"traceutil/trace.go:171","msg":"trace[1728344268] transaction","detail":"{read_only:false; response_revision:6207; number_of_response:1; }","duration":"107.922189ms","start":"2026-10-17T11:41:07.928942Z","end":"2026-10-17T11:41:08.036865Z","steps":["trace[1728344268] 'process raft request' (duration: 107.653733ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:45:31.356163Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5883} {"level":"info","ts":"2026-10-17T11:45:31.453171Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5883,"took":"95.272977ms","hash":1969460683,"current-db-size-bytes":56479744,"current-db-size":"56 MB","current-db-size-in-use-bytes":26144768,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-17T11:45:31.453236Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1969460683,"revision":5883,"compact-revision":2977} {"level":"info","ts":"2026-10-17T11:46:51.768708Z","caller":"traceutil/trace.go:171","msg":"trace[1554248090] transaction","detail":"{read_only:false; response_revision:8694; number_of_response:1; }","duration":"304.983269ms","start":"2026-10-17T11:46:51.4637Z","end":"2026-10-17T11:46:51.768683Z","steps":["trace[1554248090] 'process raft request' (duration: 304.820825ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:46:51.768872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:46:51.463671Z","time spent":"305.116881ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:46:52.00474Z","caller":"traceutil/trace.go:171","msg":"trace[1751669973] transaction","detail":"{read_only:false; response_revision:8695; number_of_response:1; }","duration":"158.688659ms","start":"2026-10-17T11:46:51.846023Z","end":"2026-10-17T11:46:52.004711Z","steps":["trace[1751669973] 'process raft request' (duration: 156.468927ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:46:53.981529Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002339.wal"} {"level":"info","ts":"2026-10-17T11:47:02.854561Z","caller":"traceutil/trace.go:171","msg":"trace[1068260944] transaction","detail":"{read_only:false; response_revision:8749; number_of_response:1; }","duration":"270.596225ms","start":"2026-10-17T11:47:02.583937Z","end":"2026-10-17T11:47:02.854533Z","steps":["trace[1068260944] 'process raft request' (duration: 270.442941ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:47:02.954366Z","caller":"traceutil/trace.go:171","msg":"trace[338045776] transaction","detail":"{read_only:false; response_revision:8750; number_of_response:1; }","duration":"366.366154ms","start":"2026-10-17T11:47:02.587974Z","end":"2026-10-17T11:47:02.954341Z","steps":["trace[338045776] 'process raft request' (duration: 313.684852ms)","trace[338045776] 'compare' (duration: 52.558929ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:47:02.954501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:02.587964Z","time spent":"366.465576ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:47:03.635866Z","caller":"traceutil/trace.go:171","msg":"trace[97354320] linearizableReadLoop","detail":"{readStateIndex:9069; appliedIndex:9068; }","duration":"272.834297ms","start":"2026-10-17T11:47:03.36301Z","end":"2026-10-17T11:47:03.635845Z","steps":["trace[97354320] 'read index received' (duration: 272.643053ms)","trace[97354320] 'applied index is now lower than readState.Index' (duration: 190.224µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:47:03.635939Z","caller":"traceutil/trace.go:171","msg":"trace[1139523810] transaction","detail":"{read_only:false; response_revision:8755; number_of_response:1; }","duration":"283.924747ms","start":"2026-10-17T11:47:03.35198Z","end":"2026-10-17T11:47:03.635905Z","steps":["trace[1139523810] 'process raft request' (duration: 283.720102ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:47:03.6361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.046562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-hp8hx\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-10-17T11:47:03.636183Z","caller":"traceutil/trace.go:171","msg":"trace[1718907899] range","detail":"{range_begin:/registry/pods/openstack/keepalived-hp8hx; range_end:; response_count:1; response_revision:8755; }","duration":"273.191126ms","start":"2026-10-17T11:47:03.362976Z","end":"2026-10-17T11:47:03.636167Z","steps":["trace[1718907899] 'agreement among raft nodes before linearized reading' (duration: 272.95952ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:47:33.308673Z","caller":"traceutil/trace.go:171","msg":"trace[1432865754] transaction","detail":"{read_only:false; response_revision:8963; number_of_response:1; }","duration":"330.718975ms","start":"2026-10-17T11:47:32.97792Z","end":"2026-10-17T11:47:33.308639Z","steps":["trace[1432865754] 'process raft request' (duration: 330.536211ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:47:33.308911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:32.977893Z","time spent":"330.871478ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:47:33.552652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.173948ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T11:47:33.552757Z","caller":"traceutil/trace.go:171","msg":"trace[1420341299] linearizableReadLoop","detail":"{readStateIndex:9287; appliedIndex:9285; }","duration":"389.166793ms","start":"2026-10-17T11:47:33.163572Z","end":"2026-10-17T11:47:33.552738Z","steps":["trace[1420341299] 'read index received' (duration: 144.987405ms)","trace[1420341299] 'applied index is now lower than readState.Index' (duration: 244.178058ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:47:33.552824Z","caller":"traceutil/trace.go:171","msg":"trace[327465251] transaction","detail":"{read_only:false; response_revision:8964; number_of_response:1; }","duration":"479.239342ms","start":"2026-10-17T11:47:33.073546Z","end":"2026-10-17T11:47:33.552785Z","steps":["trace[327465251] 'process raft request' (duration: 316.84726ms)","trace[327465251] 'compare' (duration: 161.86897ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:47:33.552946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:33.073521Z","time spent":"479.375346ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:47:33.552957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.371108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:47:33.553013Z","caller":"traceutil/trace.go:171","msg":"trace[1372922175] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8964; }","duration":"389.47683ms","start":"2026-10-17T11:47:33.163523Z","end":"2026-10-17T11:47:33.553Z","steps":["trace[1372922175] 'agreement among raft nodes before linearized reading' (duration: 389.371138ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:47:33.553048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:47:33.163507Z","time spent":"389.535922ms","remote":"127.0.0.1:53786","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-10-17T11:47:33.553063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.47716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1990"} {"level":"warn","ts":"2026-10-17T11:47:33.553072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.35772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-10-17T11:47:33.553139Z","caller":"traceutil/trace.go:171","msg":"trace[3481085] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8964; }","duration":"132.474622ms","start":"2026-10-17T11:47:33.420651Z","end":"2026-10-17T11:47:33.553125Z","steps":["trace[3481085] 'agreement among raft nodes before linearized reading' (duration: 132.296828ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:47:33.553187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.197246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-10-17T11:47:33.553015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.605231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-17T11:47:33.553219Z","caller":"traceutil/trace.go:171","msg":"trace[66262669] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8964; }","duration":"211.263717ms","start":"2026-10-17T11:47:33.341948Z","end":"2026-10-17T11:47:33.553212Z","steps":["trace[66262669] 'agreement among raft nodes before linearized reading' (duration: 211.163685ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:47:33.553221Z","caller":"traceutil/trace.go:171","msg":"trace[1078600786] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8964; }","duration":"230.851146ms","start":"2026-10-17T11:47:33.322362Z","end":"2026-10-17T11:47:33.553213Z","steps":["trace[1078600786] 'agreement among raft nodes before linearized reading' (duration: 230.553119ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:47:33.553306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.267726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-17T11:47:33.553096Z","caller":"traceutil/trace.go:171","msg":"trace[233114510] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:8964; }","duration":"178.50507ms","start":"2026-10-17T11:47:33.37458Z","end":"2026-10-17T11:47:33.553085Z","steps":["trace[233114510] 'agreement among raft nodes before linearized reading' (duration: 178.453919ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:47:33.55333Z","caller":"traceutil/trace.go:171","msg":"trace[2024151831] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8964; }","duration":"123.326198ms","start":"2026-10-17T11:47:33.429996Z","end":"2026-10-17T11:47:33.553322Z","steps":["trace[2024151831] 'agreement among raft nodes before linearized reading' (duration: 123.264367ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:47:45.787726Z","caller":"traceutil/trace.go:171","msg":"trace[1453447737] linearizableReadLoop","detail":"{readStateIndex:9354; appliedIndex:9353; }","duration":"176.296388ms","start":"2026-10-17T11:47:45.611409Z","end":"2026-10-17T11:47:45.787705Z","steps":["trace[1453447737] 'read index received' (duration: 176.078153ms)","trace[1453447737] 'applied index is now lower than readState.Index' (duration: 217.385µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:47:45.787804Z","caller":"traceutil/trace.go:171","msg":"trace[1528964126] transaction","detail":"{read_only:false; response_revision:9028; number_of_response:1; }","duration":"192.831966ms","start":"2026-10-17T11:47:45.594942Z","end":"2026-10-17T11:47:45.787774Z","steps":["trace[1528964126] 'process raft request' (duration: 192.610991ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:47:45.787949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.525934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-10-17T11:47:45.78799Z","caller":"traceutil/trace.go:171","msg":"trace[2005687067] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9028; }","duration":"176.584996ms","start":"2026-10-17T11:47:45.611395Z","end":"2026-10-17T11:47:45.78798Z","steps":["trace[2005687067] 'agreement among raft nodes before linearized reading' (duration: 176.434062ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:47:45.787991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.844443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-10-17T11:47:45.788018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.443247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-10-17T11:47:45.788032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.452761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-10-17T11:47:45.788038Z","caller":"traceutil/trace.go:171","msg":"trace[849816425] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9028; }","duration":"159.932366ms","start":"2026-10-17T11:47:45.628091Z","end":"2026-10-17T11:47:45.788024Z","steps":["trace[849816425] 'agreement among raft nodes before linearized reading' (duration: 159.796412ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:47:45.788045Z","caller":"traceutil/trace.go:171","msg":"trace[1673577563] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9028; }","duration":"154.501128ms","start":"2026-10-17T11:47:45.633537Z","end":"2026-10-17T11:47:45.788038Z","steps":["trace[1673577563] 'agreement among raft nodes before linearized reading' (duration: 154.376225ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:47:45.78806Z","caller":"traceutil/trace.go:171","msg":"trace[1362228172] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9028; }","duration":"155.501371ms","start":"2026-10-17T11:47:45.632549Z","end":"2026-10-17T11:47:45.788051Z","steps":["trace[1362228172] 'agreement among raft nodes before linearized reading' (duration: 155.400459ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:48:47.792675Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"9755887b76c83964","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T11:48:47.806829Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-17T11:48:47.80692Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-10-17T11:49:02.288105Z","caller":"traceutil/trace.go:171","msg":"trace[1621011063] transaction","detail":"{read_only:false; response_revision:9813; number_of_response:1; }","duration":"113.072338ms","start":"2026-10-17T11:49:02.174984Z","end":"2026-10-17T11:49:02.288057Z","steps":["trace[1621011063] 'process raft request' (duration: 50.467662ms)","trace[1621011063] 'compare' (duration: 62.406671ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:49:15.9591Z","caller":"traceutil/trace.go:171","msg":"trace[1353523638] transaction","detail":"{read_only:false; response_revision:9888; number_of_response:1; }","duration":"229.164586ms","start":"2026-10-17T11:49:15.729884Z","end":"2026-10-17T11:49:15.959049Z","steps":["trace[1353523638] 'process raft request' (duration: 229.028643ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:50:31.363779Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8037} {"level":"info","ts":"2026-10-17T11:50:31.435869Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8037,"took":"70.018071ms","hash":3792692398,"current-db-size-bytes":56479744,"current-db-size":"56 MB","current-db-size-in-use-bytes":27901952,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-17T11:50:31.43594Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3792692398,"revision":8037,"compact-revision":5883} {"level":"info","ts":"2026-10-17T11:54:55.454021Z","caller":"traceutil/trace.go:171","msg":"trace[1013063760] transaction","detail":"{read_only:false; response_revision:12329; number_of_response:1; }","duration":"116.721636ms","start":"2026-10-17T11:54:55.337273Z","end":"2026-10-17T11:54:55.453995Z","steps":["trace[1013063760] 'process raft request' (duration: 116.569482ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:54:56.594819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.76078ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T11:54:56.595267Z","caller":"traceutil/trace.go:171","msg":"trace[287043816] linearizableReadLoop","detail":"{readStateIndex:12767; appliedIndex:12765; }","duration":"299.599223ms","start":"2026-10-17T11:54:56.295645Z","end":"2026-10-17T11:54:56.595244Z","steps":["trace[287043816] 'read index received' (duration: 175.273179ms)","trace[287043816] 'applied index is now lower than readState.Index' (duration: 124.324604ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:54:56.595323Z","caller":"traceutil/trace.go:171","msg":"trace[1716951755] transaction","detail":"{read_only:false; response_revision:12336; number_of_response:1; }","duration":"342.088949ms","start":"2026-10-17T11:54:56.253203Z","end":"2026-10-17T11:54:56.595291Z","steps":["trace[1716951755] 'process raft request' (duration: 341.751111ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:54:56.595335Z","caller":"traceutil/trace.go:171","msg":"trace[78691569] transaction","detail":"{read_only:false; response_revision:12335; number_of_response:1; }","duration":"342.032917ms","start":"2026-10-17T11:54:56.253023Z","end":"2026-10-17T11:54:56.595056Z","steps":["trace[78691569] 'process raft request' (duration: 217.906958ms)","trace[78691569] 'compare' (duration: 123.507025ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:54:56.595423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:54:56.253181Z","time spent":"342.192251ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:54:56.595468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:54:56.252998Z","time spent":"342.398725ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:54:56.595544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.886759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-17T11:54:56.595654Z","caller":"traceutil/trace.go:171","msg":"trace[2030385127] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:12336; }","duration":"300.039703ms","start":"2026-10-17T11:54:56.295596Z","end":"2026-10-17T11:54:56.595635Z","steps":["trace[2030385127] 'agreement among raft nodes before linearized reading' (duration: 299.713735ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:54:56.59571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:54:56.295582Z","time spent":"300.113294ms","remote":"127.0.0.1:54012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":63,"response size":30,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"info","ts":"2026-10-17T11:55:31.373308Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10401} {"level":"info","ts":"2026-10-17T11:55:31.461737Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10401,"took":"85.569666ms","hash":2522052933,"current-db-size-bytes":56479744,"current-db-size":"56 MB","current-db-size-in-use-bytes":25415680,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-10-17T11:55:31.46182Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2522052933,"revision":10401,"compact-revision":8037} {"level":"info","ts":"2026-10-17T12:00:31.381076Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12571} {"level":"info","ts":"2026-10-17T12:00:31.463563Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12571,"took":"79.727459ms","hash":2223662703,"current-db-size-bytes":56479744,"current-db-size":"56 MB","current-db-size-in-use-bytes":27766784,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-17T12:00:31.46364Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2223662703,"revision":12571,"compact-revision":10401} {"level":"info","ts":"2026-10-17T12:01:37.161488Z","caller":"traceutil/trace.go:171","msg":"trace[1883852548] transaction","detail":"{read_only:false; response_revision:15024; number_of_response:1; }","duration":"112.428415ms","start":"2026-10-17T12:01:37.04901Z","end":"2026-10-17T12:01:37.161439Z","steps":["trace[1883852548] 'process raft request' (duration: 109.209339ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:01:45.352546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.098802ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T12:01:45.353002Z","caller":"traceutil/trace.go:171","msg":"trace[1215787561] linearizableReadLoop","detail":"{readStateIndex:15606; appliedIndex:15605; }","duration":"188.092969ms","start":"2026-10-17T12:01:45.164885Z","end":"2026-10-17T12:01:45.352978Z","steps":["trace[1215787561] 'read index received' (duration: 71.447395ms)","trace[1215787561] 'applied index is now lower than readState.Index' (duration: 116.643434ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:01:45.353101Z","caller":"traceutil/trace.go:171","msg":"trace[1546045250] transaction","detail":"{read_only:false; response_revision:15078; number_of_response:1; }","duration":"206.47526ms","start":"2026-10-17T12:01:45.146574Z","end":"2026-10-17T12:01:45.353049Z","steps":["trace[1546045250] 'process raft request' (duration: 89.741904ms)","trace[1546045250] 'compare' (duration: 115.832735ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T12:01:45.353148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.265833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T12:01:45.353181Z","caller":"traceutil/trace.go:171","msg":"trace[379036129] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15078; }","duration":"188.361175ms","start":"2026-10-17T12:01:45.164808Z","end":"2026-10-17T12:01:45.353169Z","steps":["trace[379036129] 'agreement among raft nodes before linearized reading' (duration: 188.260773ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:01:45.410711Z","caller":"traceutil/trace.go:171","msg":"trace[930593254] transaction","detail":"{read_only:false; response_revision:15079; number_of_response:1; }","duration":"217.714033ms","start":"2026-10-17T12:01:45.192968Z","end":"2026-10-17T12:01:45.410682Z","steps":["trace[930593254] 'process raft request' (duration: 217.441806ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:01:45.411057Z","caller":"traceutil/trace.go:171","msg":"trace[194017035] transaction","detail":"{read_only:false; response_revision:15080; number_of_response:1; }","duration":"216.193477ms","start":"2026-10-17T12:01:45.194849Z","end":"2026-10-17T12:01:45.411043Z","steps":["trace[194017035] 'process raft request' (duration: 215.777687ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:01:45.411099Z","caller":"traceutil/trace.go:171","msg":"trace[1801948639] transaction","detail":"{read_only:false; response_revision:15081; number_of_response:1; }","duration":"200.148322ms","start":"2026-10-17T12:01:45.210928Z","end":"2026-10-17T12:01:45.411076Z","steps":["trace[1801948639] 'process raft request' (duration: 199.962707ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:01:46.258446Z","caller":"traceutil/trace.go:171","msg":"trace[1568747367] linearizableReadLoop","detail":"{readStateIndex:15610; appliedIndex:15609; }","duration":"276.634274ms","start":"2026-10-17T12:01:45.981777Z","end":"2026-10-17T12:01:46.258411Z","steps":["trace[1568747367] 'read index received' (duration: 276.268205ms)","trace[1568747367] 'applied index is now lower than readState.Index' (duration: 364.489µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:01:46.258562Z","caller":"traceutil/trace.go:171","msg":"trace[103685056] transaction","detail":"{read_only:false; response_revision:15082; number_of_response:1; }","duration":"309.580946ms","start":"2026-10-17T12:01:45.94894Z","end":"2026-10-17T12:01:46.258521Z","steps":["trace[103685056] 'process raft request' (duration: 309.112555ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:01:46.258676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.826588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-10-17T12:01:46.258743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:01:45.948912Z","time spent":"309.73376ms","remote":"127.0.0.1:54002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12483,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T12:01:46.259303Z","caller":"traceutil/trace.go:171","msg":"trace[810529431] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusrules/; range_end:/registry/monitoring.coreos.com/prometheusrules0; response_count:0; response_revision:15082; }","duration":"276.978822ms","start":"2026-10-17T12:01:45.981734Z","end":"2026-10-17T12:01:46.258713Z","steps":["trace[810529431] 'agreement among raft nodes before linearized reading' (duration: 276.798438ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:01:56.522191Z","caller":"traceutil/trace.go:171","msg":"trace[114984914] transaction","detail":"{read_only:false; response_revision:15254; number_of_response:1; }","duration":"158.129797ms","start":"2026-10-17T12:01:56.364038Z","end":"2026-10-17T12:01:56.522167Z","steps":["trace[114984914] 'process raft request' (duration: 157.968443ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:01:56.898758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.861248ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T12:01:56.898942Z","caller":"traceutil/trace.go:171","msg":"trace[1161420314] linearizableReadLoop","detail":"{readStateIndex:15786; appliedIndex:15785; }","duration":"354.172022ms","start":"2026-10-17T12:01:56.544741Z","end":"2026-10-17T12:01:56.898913Z","steps":["trace[1161420314] 'read index received' (duration: 181.989636ms)","trace[1161420314] 'applied index is now lower than readState.Index' (duration: 172.180656ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:01:56.899058Z","caller":"traceutil/trace.go:171","msg":"trace[362844299] transaction","detail":"{read_only:false; response_revision:15255; number_of_response:1; }","duration":"357.570311ms","start":"2026-10-17T12:01:56.541454Z","end":"2026-10-17T12:01:56.899025Z","steps":["trace[362844299] 'process raft request' (duration: 185.351315ms)","trace[362844299] 'compare' (duration: 171.734175ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T12:01:56.899122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:01:56.54142Z","time spent":"357.670014ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T12:01:56.89928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.802313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-hp8hx\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-10-17T12:01:56.899368Z","caller":"traceutil/trace.go:171","msg":"trace[1570118703] range","detail":"{range_begin:/registry/pods/openstack/keepalived-hp8hx; range_end:; response_count:1; response_revision:15255; }","duration":"225.894475ms","start":"2026-10-17T12:01:56.673448Z","end":"2026-10-17T12:01:56.899343Z","steps":["trace[1570118703] 'agreement among raft nodes before linearized reading' (duration: 225.650099ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:01:56.899684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.439204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-10-17T12:01:56.899706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.746367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/ovn-controller-default-5xq9l.18df4f6f1475a165\" ","response":"range_response_count:1 size:783"} {"level":"info","ts":"2026-10-17T12:01:56.899774Z","caller":"traceutil/trace.go:171","msg":"trace[1579215533] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:15255; }","duration":"132.588377ms","start":"2026-10-17T12:01:56.767161Z","end":"2026-10-17T12:01:56.89975Z","steps":["trace[1579215533] 'agreement among raft nodes before linearized reading' (duration: 132.28955ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:01:56.899798Z","caller":"traceutil/trace.go:171","msg":"trace[943109806] range","detail":"{range_begin:/registry/events/openstack/ovn-controller-default-5xq9l.18df4f6f1475a165; range_end:; response_count:1; response_revision:15255; }","duration":"154.906961ms","start":"2026-10-17T12:01:56.744867Z","end":"2026-10-17T12:01:56.899774Z","steps":["trace[943109806] 'agreement among raft nodes before linearized reading' (duration: 154.608984ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:01:56.900189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.448551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-10-17T12:01:56.900234Z","caller":"traceutil/trace.go:171","msg":"trace[300833461] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:15255; }","duration":"355.501122ms","start":"2026-10-17T12:01:56.544723Z","end":"2026-10-17T12:01:56.900224Z","steps":["trace[300833461] 'agreement among raft nodes before linearized reading' (duration: 354.717294ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:01:56.900262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:01:56.544664Z","time spent":"355.590825ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-10-17T12:05:31.389631Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14602} {"level":"info","ts":"2026-10-17T12:05:31.483556Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14602,"took":"90.708276ms","hash":4283313005,"current-db-size-bytes":56479744,"current-db-size":"56 MB","current-db-size-in-use-bytes":32071680,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-17T12:05:31.483632Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4283313005,"revision":14602,"compact-revision":12571} {"level":"warn","ts":"2026-10-17T12:09:13.177813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.675709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-qbn7r\" ","response":"range_response_count:1 size:9789"} {"level":"info","ts":"2026-10-17T12:09:13.178033Z","caller":"traceutil/trace.go:171","msg":"trace[366124548] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-qbn7r; range_end:; response_count:1; response_revision:18838; }","duration":"201.942715ms","start":"2026-10-17T12:09:12.976054Z","end":"2026-10-17T12:09:13.177997Z","steps":["trace[366124548] 'range keys from in-memory index tree' (duration: 201.486114ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:09:13.177923Z","caller":"traceutil/trace.go:171","msg":"trace[816942881] linearizableReadLoop","detail":"{readStateIndex:19485; appliedIndex:19484; }","duration":"152.168151ms","start":"2026-10-17T12:09:13.025732Z","end":"2026-10-17T12:09:13.1779Z","steps":["trace[816942881] 'read index received' (duration: 150.530802ms)","trace[816942881] 'applied index is now lower than readState.Index' (duration: 1.636289ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T12:09:13.178455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.703223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-n5dwq\" ","response":"range_response_count:1 size:22093"} {"level":"info","ts":"2026-10-17T12:09:13.178534Z","caller":"traceutil/trace.go:171","msg":"trace[779287364] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-n5dwq; range_end:; response_count:1; response_revision:18839; }","duration":"152.796095ms","start":"2026-10-17T12:09:13.025726Z","end":"2026-10-17T12:09:13.178522Z","steps":["trace[779287364] 'agreement among raft nodes before linearized reading' (duration: 152.58035ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:09:13.178744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.735604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T12:09:13.178826Z","caller":"traceutil/trace.go:171","msg":"trace[1692547065] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:18839; }","duration":"143.867406ms","start":"2026-10-17T12:09:13.03494Z","end":"2026-10-17T12:09:13.178808Z","steps":["trace[1692547065] 'agreement among raft nodes before linearized reading' (duration: 143.737213ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:09:13.179152Z","caller":"traceutil/trace.go:171","msg":"trace[1196609971] transaction","detail":"{read_only:false; response_revision:18839; number_of_response:1; }","duration":"155.035608ms","start":"2026-10-17T12:09:13.023051Z","end":"2026-10-17T12:09:13.178087Z","steps":["trace[1196609971] 'process raft request' (duration: 153.285627ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:09:20.746217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.247637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T12:09:20.746309Z","caller":"traceutil/trace.go:171","msg":"trace[583434678] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:18891; }","duration":"221.391741ms","start":"2026-10-17T12:09:20.524894Z","end":"2026-10-17T12:09:20.746286Z","steps":["trace[583434678] 'count revisions from in-memory index tree' (duration: 221.169165ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:09:20.746423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.306734ms","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:8"} {"level":"info","ts":"2026-10-17T12:09:20.746473Z","caller":"traceutil/trace.go:171","msg":"trace[798560549] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:18891; }","duration":"264.385817ms","start":"2026-10-17T12:09:20.482075Z","end":"2026-10-17T12:09:20.74646Z","steps":["trace[798560549] 'count revisions from in-memory index tree' (duration: 264.232863ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:09:21.37605Z","caller":"traceutil/trace.go:171","msg":"trace[1342157528] linearizableReadLoop","detail":"{readStateIndex:19540; appliedIndex:19539; }","duration":"211.597311ms","start":"2026-10-17T12:09:21.164414Z","end":"2026-10-17T12:09:21.376012Z","steps":["trace[1342157528] 'read index received' (duration: 211.55159ms)","trace[1342157528] 'applied index is now lower than readState.Index' (duration: 44.881µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:09:21.376096Z","caller":"traceutil/trace.go:171","msg":"trace[1745505191] transaction","detail":"{read_only:false; response_revision:18892; number_of_response:1; }","duration":"485.303055ms","start":"2026-10-17T12:09:20.890769Z","end":"2026-10-17T12:09:21.376072Z","steps":["trace[1745505191] 'process raft request' (duration: 485.119291ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:09:21.376178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.755745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T12:09:21.376208Z","caller":"traceutil/trace.go:171","msg":"trace[1568073142] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18892; }","duration":"211.836437ms","start":"2026-10-17T12:09:21.164362Z","end":"2026-10-17T12:09:21.376198Z","steps":["trace[1568073142] 'agreement among raft nodes before linearized reading' (duration: 211.772996ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:09:21.376315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:09:20.890745Z","time spent":"485.422449ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T12:09:21.528542Z","caller":"traceutil/trace.go:171","msg":"trace[803124047] transaction","detail":"{read_only:false; response_revision:18893; number_of_response:1; }","duration":"321.860882ms","start":"2026-10-17T12:09:21.206659Z","end":"2026-10-17T12:09:21.52852Z","steps":["trace[803124047] 'process raft request' (duration: 321.687297ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:09:21.528729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:09:21.20664Z","time spent":"322.008655ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T12:09:21.528854Z","caller":"traceutil/trace.go:171","msg":"trace[1816632351] linearizableReadLoop","detail":"{readStateIndex:19544; appliedIndex:19540; }","duration":"152.715454ms","start":"2026-10-17T12:09:21.376113Z","end":"2026-10-17T12:09:21.528829Z","steps":["trace[1816632351] 'read index received' (duration: 152.262943ms)","trace[1816632351] 'applied index is now lower than readState.Index' (duration: 451.321µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:09:21.528998Z","caller":"traceutil/trace.go:171","msg":"trace[2119543087] transaction","detail":"{read_only:false; response_revision:18896; number_of_response:1; }","duration":"284.590709ms","start":"2026-10-17T12:09:21.244378Z","end":"2026-10-17T12:09:21.528969Z","steps":["trace[2119543087] 'process raft request' (duration: 284.401495ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:09:21.528978Z","caller":"traceutil/trace.go:171","msg":"trace[338897730] transaction","detail":"{read_only:false; response_revision:18894; number_of_response:1; }","duration":"319.527367ms","start":"2026-10-17T12:09:21.209224Z","end":"2026-10-17T12:09:21.528751Z","steps":["trace[338897730] 'process raft request' (duration: 319.252131ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:09:21.529126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.103016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T12:09:21.529164Z","caller":"traceutil/trace.go:171","msg":"trace[306025085] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18896; }","duration":"151.172747ms","start":"2026-10-17T12:09:21.377977Z","end":"2026-10-17T12:09:21.52915Z","steps":["trace[306025085] 'agreement among raft nodes before linearized reading' (duration: 151.123296ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:09:21.529192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.246717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-qbn7r\" ","response":"range_response_count:1 size:9789"} {"level":"info","ts":"2026-10-17T12:09:21.529224Z","caller":"traceutil/trace.go:171","msg":"trace[1909503173] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-qbn7r; range_end:; response_count:1; response_revision:18896; }","duration":"227.296879ms","start":"2026-10-17T12:09:21.301918Z","end":"2026-10-17T12:09:21.529215Z","steps":["trace[1909503173] 'agreement among raft nodes before linearized reading' (duration: 227.163426ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:09:21.529051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.306676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-17T12:09:21.529217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.929722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-n5dwq\" ","response":"range_response_count:1 size:22093"} {"level":"warn","ts":"2026-10-17T12:09:21.529229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.535994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"warn","ts":"2026-10-17T12:09:21.529232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.079234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-10-17T12:09:21.529302Z","caller":"traceutil/trace.go:171","msg":"trace[996527015] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-n5dwq; range_end:; response_count:1; response_revision:18896; }","duration":"216.044875ms","start":"2026-10-17T12:09:21.313235Z","end":"2026-10-17T12:09:21.52928Z","steps":["trace[996527015] 'agreement among raft nodes before linearized reading' (duration: 215.763969ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:09:21.529307Z","caller":"traceutil/trace.go:171","msg":"trace[141012538] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:18896; }","duration":"162.647976ms","start":"2026-10-17T12:09:21.366642Z","end":"2026-10-17T12:09:21.52929Z","steps":["trace[141012538] 'agreement among raft nodes before linearized reading' (duration: 162.42316ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:09:21.529309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.647996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-10-17T12:09:21.529215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:09:21.209211Z","time spent":"319.894235ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T12:09:21.529356Z","caller":"traceutil/trace.go:171","msg":"trace[1456116626] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:18896; }","duration":"109.693367ms","start":"2026-10-17T12:09:21.41965Z","end":"2026-10-17T12:09:21.529343Z","steps":["trace[1456116626] 'agreement among raft nodes before linearized reading' (duration: 109.592585ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:09:21.52943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.775036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-10-17T12:09:21.529312Z","caller":"traceutil/trace.go:171","msg":"trace[685389373] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18896; }","duration":"171.194626ms","start":"2026-10-17T12:09:21.358105Z","end":"2026-10-17T12:09:21.5293Z","steps":["trace[685389373] 'agreement among raft nodes before linearized reading' (duration: 171.027472ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:09:21.529017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.453588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-10-17T12:09:21.529462Z","caller":"traceutil/trace.go:171","msg":"trace[848699938] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18896; }","duration":"114.830567ms","start":"2026-10-17T12:09:21.414623Z","end":"2026-10-17T12:09:21.529453Z","steps":["trace[848699938] 'agreement among raft nodes before linearized reading' (duration: 114.663804ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:09:21.529265Z","caller":"traceutil/trace.go:171","msg":"trace[25994405] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemmirrors/; range_end:/registry/ceph.rook.io/cephfilesystemmirrors0; response_count:0; response_revision:18896; }","duration":"167.586762ms","start":"2026-10-17T12:09:21.361664Z","end":"2026-10-17T12:09:21.529251Z","steps":["trace[25994405] 'agreement among raft nodes before linearized reading' (duration: 167.300415ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:09:21.529492Z","caller":"traceutil/trace.go:171","msg":"trace[266541167] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18896; }","duration":"164.96564ms","start":"2026-10-17T12:09:21.364506Z","end":"2026-10-17T12:09:21.529471Z","steps":["trace[266541167] 'agreement among raft nodes before linearized reading' (duration: 164.355296ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:09:21.529499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.123597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-10-17T12:09:21.529577Z","caller":"traceutil/trace.go:171","msg":"trace[496991759] transaction","detail":"{read_only:false; response_revision:18895; number_of_response:1; }","duration":"317.136401ms","start":"2026-10-17T12:09:21.212394Z","end":"2026-10-17T12:09:21.52953Z","steps":["trace[496991759] 'process raft request' (duration: 316.262671ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:09:21.529602Z","caller":"traceutil/trace.go:171","msg":"trace[915890132] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:18896; }","duration":"175.286981ms","start":"2026-10-17T12:09:21.354286Z","end":"2026-10-17T12:09:21.529573Z","steps":["trace[915890132] 'agreement among raft nodes before linearized reading' (duration: 174.894812ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:09:21.529669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:09:21.212381Z","time spent":"317.227613ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T12:10:02.566625Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"9755887b76c83964","local-member-applied-index":20005,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T12:10:02.575483Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20005} {"level":"info","ts":"2026-10-17T12:10:02.575612Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15005} {"level":"info","ts":"2026-10-17T12:10:31.397423Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17090} {"level":"info","ts":"2026-10-17T12:10:31.499385Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17090,"took":"98.7242ms","hash":2735449616,"current-db-size-bytes":56479744,"current-db-size":"56 MB","current-db-size-in-use-bytes":34353152,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-10-17T12:10:31.499461Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2735449616,"revision":17090,"compact-revision":14602} {"level":"info","ts":"2026-10-17T12:15:31.247336Z","caller":"traceutil/trace.go:171","msg":"trace[685311678] transaction","detail":"{read_only:false; response_revision:21720; number_of_response:1; }","duration":"242.335967ms","start":"2026-10-17T12:15:31.004987Z","end":"2026-10-17T12:15:31.247323Z","steps":["trace[685311678] 'process raft request' (duration: 242.144273ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:15:31.247251Z","caller":"traceutil/trace.go:171","msg":"trace[893280165] transaction","detail":"{read_only:false; response_revision:21719; number_of_response:1; }","duration":"265.633673ms","start":"2026-10-17T12:15:30.981565Z","end":"2026-10-17T12:15:31.247199Z","steps":["trace[893280165] 'process raft request' (duration: 265.408148ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:15:31.463271Z","caller":"traceutil/trace.go:171","msg":"trace[1910154427] linearizableReadLoop","detail":"{readStateIndex:22462; appliedIndex:22459; }","duration":"309.44237ms","start":"2026-10-17T12:15:31.153793Z","end":"2026-10-17T12:15:31.463235Z","steps":["trace[1910154427] 'read index received' (duration: 93.120162ms)","trace[1910154427] 'applied index is now lower than readState.Index' (duration: 216.320268ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:15:31.463292Z","caller":"traceutil/trace.go:171","msg":"trace[1244822703] transaction","detail":"{read_only:false; response_revision:21721; number_of_response:1; }","duration":"390.735474ms","start":"2026-10-17T12:15:31.072516Z","end":"2026-10-17T12:15:31.463251Z","steps":["trace[1244822703] 'process raft request' (duration: 386.29022ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:15:31.463455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.641454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-17T12:15:31.463481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:15:31.072489Z","time spent":"390.894828ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T12:15:31.463541Z","caller":"traceutil/trace.go:171","msg":"trace[379343693] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:21721; }","duration":"309.779637ms","start":"2026-10-17T12:15:31.15374Z","end":"2026-10-17T12:15:31.46352Z","steps":["trace[379343693] 'agreement among raft nodes before linearized reading' (duration: 309.635534ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:15:31.463586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:15:31.153715Z","time spent":"309.85915ms","remote":"127.0.0.1:35070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"info","ts":"2026-10-17T12:15:31.556264Z","caller":"traceutil/trace.go:171","msg":"trace[900701894] transaction","detail":"{read_only:false; response_revision:21722; number_of_response:1; }","duration":"156.472956ms","start":"2026-10-17T12:15:31.399755Z","end":"2026-10-17T12:15:31.556228Z","steps":["trace[900701894] 'process raft request' (duration: 156.313702ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:15:31.556338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.111861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T12:15:31.556406Z","caller":"traceutil/trace.go:171","msg":"trace[1609565918] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:21722; }","duration":"233.238384ms","start":"2026-10-17T12:15:31.323151Z","end":"2026-10-17T12:15:31.556389Z","steps":["trace[1609565918] 'agreement among raft nodes before linearized reading' (duration: 233.08289ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:15:31.964294Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19706} {"level":"warn","ts":"2026-10-17T12:15:31.964501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.162023ms","expected-duration":"100ms","prefix":"","request":"header: compaction: ","response":"size:6"} {"level":"info","ts":"2026-10-17T12:15:31.965106Z","caller":"traceutil/trace.go:171","msg":"trace[1926224162] compact","detail":"{revision:19706; response_revision:21722; }","duration":"406.36641ms","start":"2026-10-17T12:15:31.558695Z","end":"2026-10-17T12:15:31.965061Z","steps":["trace[1926224162] 'process raft request' (duration: 60.530858ms)","trace[1926224162] 'check and update compact revision' (duration: 343.945198ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:15:31.965139Z","caller":"traceutil/trace.go:171","msg":"trace[1566865687] linearizableReadLoop","detail":"{readStateIndex:22464; appliedIndex:22463; }","duration":"404.839724ms","start":"2026-10-17T12:15:31.560281Z","end":"2026-10-17T12:15:31.965121Z","steps":["trace[1566865687] 'read index received' (duration: 59.039233ms)","trace[1566865687] 'applied index is now lower than readState.Index' (duration: 345.799331ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T12:15:31.965178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:15:31.558664Z","time spent":"406.508614ms","remote":"127.0.0.1:53808","response type":"/etcdserverpb.KV/Compact","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-10-17T12:15:31.965427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.08551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-10-17T12:15:31.9655Z","caller":"traceutil/trace.go:171","msg":"trace[1975411529] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:21722; }","duration":"405.226173ms","start":"2026-10-17T12:15:31.560257Z","end":"2026-10-17T12:15:31.965483Z","steps":["trace[1975411529] 'agreement among raft nodes before linearized reading' (duration: 404.940496ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:15:31.965549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:15:31.560244Z","time spent":"405.292185ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-10-17T12:15:31.965838Z","caller":"traceutil/trace.go:171","msg":"trace[1829389933] transaction","detail":"{read_only:false; response_revision:21723; number_of_response:1; }","duration":"405.235314ms","start":"2026-10-17T12:15:31.560585Z","end":"2026-10-17T12:15:31.965821Z","steps":["trace[1829389933] 'process raft request' (duration: 404.523257ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:15:31.966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:15:31.560567Z","time spent":"405.329016ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T12:15:31.967249Z","caller":"traceutil/trace.go:171","msg":"trace[717505743] transaction","detail":"{read_only:false; response_revision:21724; number_of_response:1; }","duration":"406.618976ms","start":"2026-10-17T12:15:31.560605Z","end":"2026-10-17T12:15:31.967224Z","steps":["trace[717505743] 'process raft request' (duration: 405.197892ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:15:31.967395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:15:31.56058Z","time spent":"406.726939ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T12:15:31.968031Z","caller":"traceutil/trace.go:171","msg":"trace[1399250923] transaction","detail":"{read_only:false; response_revision:21725; number_of_response:1; }","duration":"407.343583ms","start":"2026-10-17T12:15:31.560658Z","end":"2026-10-17T12:15:31.968001Z","steps":["trace[1399250923] 'process raft request' (duration: 406.540374ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:15:31.968134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:15:31.560638Z","time spent":"407.443456ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T12:15:31.968863Z","caller":"traceutil/trace.go:171","msg":"trace[657281998] transaction","detail":"{read_only:false; response_revision:21726; number_of_response:1; }","duration":"199.280909ms","start":"2026-10-17T12:15:31.76956Z","end":"2026-10-17T12:15:31.968841Z","steps":["trace[657281998] 'process raft request' (duration: 198.266675ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:15:31.969829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.184646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"warn","ts":"2026-10-17T12:15:31.969882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.564885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T12:15:31.96989Z","caller":"traceutil/trace.go:171","msg":"trace[1922915623] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21727; }","duration":"406.269758ms","start":"2026-10-17T12:15:31.563605Z","end":"2026-10-17T12:15:31.969875Z","steps":["trace[1922915623] 'agreement among raft nodes before linearized reading' (duration: 406.068673ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:15:31.969914Z","caller":"traceutil/trace.go:171","msg":"trace[1117923686] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:21727; }","duration":"266.633847ms","start":"2026-10-17T12:15:31.70327Z","end":"2026-10-17T12:15:31.969904Z","steps":["trace[1117923686] 'agreement among raft nodes before linearized reading' (duration: 266.525334ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:15:31.969952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:15:31.563596Z","time spent":"406.324329ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-17T12:15:31.96996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.775093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagerconfigs/\" range_end:\"/registry/monitoring.coreos.com/alertmanagerconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T12:15:31.970046Z","caller":"traceutil/trace.go:171","msg":"trace[363490711] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagerconfigs/; range_end:/registry/monitoring.coreos.com/alertmanagerconfigs0; response_count:0; response_revision:21727; }","duration":"226.934936ms","start":"2026-10-17T12:15:31.743092Z","end":"2026-10-17T12:15:31.970027Z","steps":["trace[363490711] 'agreement among raft nodes before linearized reading' (duration: 226.66841ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:15:31.969993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.112966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-17T12:15:31.970255Z","caller":"traceutil/trace.go:171","msg":"trace[1102527079] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:21727; }","duration":"325.425114ms","start":"2026-10-17T12:15:31.644819Z","end":"2026-10-17T12:15:31.970245Z","steps":["trace[1102527079] 'agreement among raft nodes before linearized reading' (duration: 324.959073ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:15:31.970291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:15:31.644789Z","time spent":"325.490455ms","remote":"127.0.0.1:54300","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":17,"response size":31,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"info","ts":"2026-10-17T12:15:32.094186Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19706,"took":"120.816571ms","hash":1802018988,"current-db-size-bytes":56479744,"current-db-size":"56 MB","current-db-size-in-use-bytes":30265344,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-17T12:15:32.09426Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1802018988,"revision":19706,"compact-revision":17090} {"level":"info","ts":"2026-10-17T12:19:39.10277Z","caller":"traceutil/trace.go:171","msg":"trace[416361723] transaction","detail":"{read_only:false; response_revision:24217; number_of_response:1; }","duration":"110.084709ms","start":"2026-10-17T12:19:38.992648Z","end":"2026-10-17T12:19:39.102733Z","steps":["trace[416361723] 'process raft request' (duration: 110.012677ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:19:39.105252Z","caller":"traceutil/trace.go:171","msg":"trace[462511995] transaction","detail":"{read_only:false; response_revision:24216; number_of_response:1; }","duration":"255.596088ms","start":"2026-10-17T12:19:38.849628Z","end":"2026-10-17T12:19:39.105224Z","steps":["trace[462511995] 'process raft request' (duration: 252.684249ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:20:31.973324Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21722} {"level":"info","ts":"2026-10-17T12:20:32.095734Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21722,"took":"117.979464ms","hash":1340821179,"current-db-size-bytes":56479744,"current-db-size":"56 MB","current-db-size-in-use-bytes":42827776,"current-db-size-in-use":"43 MB"} {"level":"info","ts":"2026-10-17T12:20:32.095812Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1340821179,"revision":21722,"compact-revision":19706} {"level":"info","ts":"2026-10-17T12:22:06.928528Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000067cb.wal"} {"level":"warn","ts":"2026-10-17T12:23:16.513519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.079064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-10-17T12:23:16.513605Z","caller":"traceutil/trace.go:171","msg":"trace[1145151735] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26330; }","duration":"129.203897ms","start":"2026-10-17T12:23:16.384384Z","end":"2026-10-17T12:23:16.513588Z","steps":["trace[1145151735] 'range keys from in-memory index tree' (duration: 128.937551ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:23:16.513776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.911982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-10-17T12:23:16.51386Z","caller":"traceutil/trace.go:171","msg":"trace[205427906] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26330; }","duration":"115.028545ms","start":"2026-10-17T12:23:16.398813Z","end":"2026-10-17T12:23:16.513841Z","steps":["trace[205427906] 'range keys from in-memory index tree' (duration: 114.664386ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:23:16.514277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.089729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-17T12:23:16.514318Z","caller":"traceutil/trace.go:171","msg":"trace[1012856998] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26330; }","duration":"104.16201ms","start":"2026-10-17T12:23:16.410146Z","end":"2026-10-17T12:23:16.514308Z","steps":["trace[1012856998] 'range keys from in-memory index tree' (duration: 104.005097ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:23:16.740643Z","caller":"traceutil/trace.go:171","msg":"trace[2070847698] transaction","detail":"{read_only:false; response_revision:26333; number_of_response:1; }","duration":"221.827996ms","start":"2026-10-17T12:23:16.518776Z","end":"2026-10-17T12:23:16.740604Z","steps":["trace[2070847698] 'process raft request' (duration: 184.124923ms)","trace[2070847698] 'compare' (duration: 37.337155ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:23:16.74068Z","caller":"traceutil/trace.go:171","msg":"trace[1435401312] transaction","detail":"{read_only:false; response_revision:26334; number_of_response:1; }","duration":"221.454498ms","start":"2026-10-17T12:23:16.519203Z","end":"2026-10-17T12:23:16.740657Z","steps":["trace[1435401312] 'process raft request' (duration: 221.308714ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:23:16.740868Z","caller":"traceutil/trace.go:171","msg":"trace[531407317] transaction","detail":"{read_only:false; response_revision:26335; number_of_response:1; }","duration":"221.583941ms","start":"2026-10-17T12:23:16.51923Z","end":"2026-10-17T12:23:16.740814Z","steps":["trace[531407317] 'process raft request' (duration: 221.373016ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:23:16.913538Z","caller":"traceutil/trace.go:171","msg":"trace[988031114] transaction","detail":"{read_only:false; response_revision:26336; number_of_response:1; }","duration":"100.33416ms","start":"2026-10-17T12:23:16.813114Z","end":"2026-10-17T12:23:16.913448Z","steps":["trace[988031114] 'process raft request' (duration: 91.263727ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:24:11.726959Z","caller":"traceutil/trace.go:171","msg":"trace[624763013] transaction","detail":"{read_only:false; response_revision:26843; number_of_response:1; }","duration":"167.014253ms","start":"2026-10-17T12:24:11.559912Z","end":"2026-10-17T12:24:11.726926Z","steps":["trace[624763013] 'process raft request' (duration: 166.793568ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:24:17.013235Z","caller":"traceutil/trace.go:171","msg":"trace[1102980948] linearizableReadLoop","detail":"{readStateIndex:27758; appliedIndex:27757; }","duration":"140.579894ms","start":"2026-10-17T12:24:16.872616Z","end":"2026-10-17T12:24:17.013196Z","steps":["trace[1102980948] 'read index received' (duration: 140.198715ms)","trace[1102980948] 'applied index is now lower than readState.Index' (duration: 379.779µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:24:17.01344Z","caller":"traceutil/trace.go:171","msg":"trace[1996402013] transaction","detail":"{read_only:false; response_revision:26875; number_of_response:1; }","duration":"142.766916ms","start":"2026-10-17T12:24:16.870659Z","end":"2026-10-17T12:24:17.013426Z","steps":["trace[1996402013] 'process raft request' (duration: 142.299705ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:24:17.013615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.984084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-10-17T12:24:17.013692Z","caller":"traceutil/trace.go:171","msg":"trace[1426868325] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26875; }","duration":"141.110417ms","start":"2026-10-17T12:24:16.872565Z","end":"2026-10-17T12:24:17.013676Z","steps":["trace[1426868325] 'agreement among raft nodes before linearized reading' (duration: 140.919302ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:24:17.260619Z","caller":"traceutil/trace.go:171","msg":"trace[1356893440] linearizableReadLoop","detail":"{readStateIndex:27759; appliedIndex:27758; }","duration":"184.475013ms","start":"2026-10-17T12:24:17.076119Z","end":"2026-10-17T12:24:17.260594Z","steps":["trace[1356893440] 'read index received' (duration: 104.928529ms)","trace[1356893440] 'applied index is now lower than readState.Index' (duration: 79.544974ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:24:17.260517Z","caller":"traceutil/trace.go:171","msg":"trace[840298668] transaction","detail":"{read_only:false; response_revision:26877; number_of_response:1; }","duration":"108.38101ms","start":"2026-10-17T12:24:17.152106Z","end":"2026-10-17T12:24:17.260487Z","steps":["trace[840298668] 'process raft request' (duration: 108.258947ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:24:17.261104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.008145ms","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-10-17T12:24:17.261277Z","caller":"traceutil/trace.go:171","msg":"trace[746112543] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26877; }","duration":"182.203629ms","start":"2026-10-17T12:24:17.079059Z","end":"2026-10-17T12:24:17.261263Z","steps":["trace[746112543] 'agreement among raft nodes before linearized reading' (duration: 181.766479ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:24:17.261077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.420497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-10-17T12:24:17.261431Z","caller":"traceutil/trace.go:171","msg":"trace[338970374] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26877; }","duration":"174.840607ms","start":"2026-10-17T12:24:17.086569Z","end":"2026-10-17T12:24:17.26141Z","steps":["trace[338970374] 'agreement among raft nodes before linearized reading' (duration: 174.274984ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:24:17.26104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.891983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-10-17T12:24:17.261044Z","caller":"traceutil/trace.go:171","msg":"trace[649329420] transaction","detail":"{read_only:false; response_revision:26876; number_of_response:1; }","duration":"242.39691ms","start":"2026-10-17T12:24:17.018154Z","end":"2026-10-17T12:24:17.260551Z","steps":["trace[649329420] 'process raft request' (duration: 162.902867ms)","trace[649329420] 'compare' (duration: 78.974411ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:24:17.261571Z","caller":"traceutil/trace.go:171","msg":"trace[1531068116] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26877; }","duration":"185.449715ms","start":"2026-10-17T12:24:17.076071Z","end":"2026-10-17T12:24:17.261521Z","steps":["trace[1531068116] 'agreement among raft nodes before linearized reading' (duration: 184.609006ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:24:17.543521Z","caller":"traceutil/trace.go:171","msg":"trace[112344981] transaction","detail":"{read_only:false; response_revision:26879; number_of_response:1; }","duration":"277.575945ms","start":"2026-10-17T12:24:17.265918Z","end":"2026-10-17T12:24:17.543494Z","steps":["trace[112344981] 'process raft request' (duration: 277.317579ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:24:17.543821Z","caller":"traceutil/trace.go:171","msg":"trace[2110620169] transaction","detail":"{read_only:false; response_revision:26880; number_of_response:1; }","duration":"277.111744ms","start":"2026-10-17T12:24:17.266677Z","end":"2026-10-17T12:24:17.543788Z","steps":["trace[2110620169] 'process raft request' (duration: 276.762176ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:24:17.54411Z","caller":"traceutil/trace.go:171","msg":"trace[174616883] linearizableReadLoop","detail":"{readStateIndex:27765; appliedIndex:27761; }","duration":"154.666565ms","start":"2026-10-17T12:24:17.389425Z","end":"2026-10-17T12:24:17.544091Z","steps":["trace[174616883] 'read index received' (duration: 153.864946ms)","trace[174616883] 'applied index is now lower than readState.Index' (duration: 800.269µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:24:17.544198Z","caller":"traceutil/trace.go:171","msg":"trace[394407601] transaction","detail":"{read_only:false; response_revision:26882; number_of_response:1; }","duration":"249.62734ms","start":"2026-10-17T12:24:17.294539Z","end":"2026-10-17T12:24:17.544166Z","steps":["trace[394407601] 'process raft request' (duration: 249.346783ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:24:17.544151Z","caller":"traceutil/trace.go:171","msg":"trace[1753639307] transaction","detail":"{read_only:false; response_revision:26881; number_of_response:1; }","duration":"269.374263ms","start":"2026-10-17T12:24:17.274612Z","end":"2026-10-17T12:24:17.543986Z","steps":["trace[1753639307] 'process raft request' (duration: 269.085096ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:24:17.544804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.356661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T12:24:17.544867Z","caller":"traceutil/trace.go:171","msg":"trace[570330826] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:26882; }","duration":"155.514565ms","start":"2026-10-17T12:24:17.389331Z","end":"2026-10-17T12:24:17.544846Z","steps":["trace[570330826] 'agreement among raft nodes before linearized reading' (duration: 154.822468ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:24:17.918887Z","caller":"traceutil/trace.go:171","msg":"trace[129103151] transaction","detail":"{read_only:false; response_revision:26883; number_of_response:1; }","duration":"519.394181ms","start":"2026-10-17T12:24:17.399456Z","end":"2026-10-17T12:24:17.91885Z","steps":["trace[129103151] 'process raft request' (duration: 477.389066ms)","trace[129103151] 'compare' (duration: 41.343709ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T12:24:17.919087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:24:17.39942Z","time spent":"519.572855ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T12:24:17.919272Z","caller":"traceutil/trace.go:171","msg":"trace[1429799183] transaction","detail":"{read_only:false; response_revision:26884; number_of_response:1; }","duration":"517.61721ms","start":"2026-10-17T12:24:17.401611Z","end":"2026-10-17T12:24:17.919228Z","steps":["trace[1429799183] 'process raft request' (duration: 517.338563ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:24:17.919301Z","caller":"traceutil/trace.go:171","msg":"trace[901938144] transaction","detail":"{read_only:false; response_revision:26885; number_of_response:1; }","duration":"506.992201ms","start":"2026-10-17T12:24:17.412281Z","end":"2026-10-17T12:24:17.919273Z","steps":["trace[901938144] 'process raft request' (duration: 506.836817ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:24:17.919363Z","caller":"traceutil/trace.go:171","msg":"trace[395095099] transaction","detail":"{read_only:false; response_revision:26887; number_of_response:1; }","duration":"170.375683ms","start":"2026-10-17T12:24:17.748955Z","end":"2026-10-17T12:24:17.91933Z","steps":["trace[395095099] 'process raft request' (duration: 170.308411ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:24:17.919432Z","caller":"traceutil/trace.go:171","msg":"trace[1450267985] transaction","detail":"{read_only:false; response_revision:26886; number_of_response:1; }","duration":"503.050768ms","start":"2026-10-17T12:24:17.416353Z","end":"2026-10-17T12:24:17.919404Z","steps":["trace[1450267985] 'process raft request' (duration: 502.836433ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:24:17.919455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:24:17.412262Z","time spent":"507.104853ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T12:24:17.919487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:24:17.401581Z","time spent":"517.784934ms","remote":"127.0.0.1:54090","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-10-17T12:24:17.91954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T12:24:17.416334Z","time spent":"503.149301ms","remote":"127.0.0.1:54090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T12:25:03.525269Z","caller":"traceutil/trace.go:171","msg":"trace[949100241] transaction","detail":"{read_only:false; response_revision:27408; number_of_response:1; }","duration":"100.620668ms","start":"2026-10-17T12:25:03.424612Z","end":"2026-10-17T12:25:03.525233Z","steps":["trace[949100241] 'process raft request' (duration: 77.946906ms)","trace[949100241] 'compare' (duration: 22.435176ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T12:25:07.748411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.196662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-10-17T12:25:07.748496Z","caller":"traceutil/trace.go:171","msg":"trace[941186137] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:27445; }","duration":"107.312994ms","start":"2026-10-17T12:25:07.641162Z","end":"2026-10-17T12:25:07.748475Z","steps":["trace[941186137] 'range keys from in-memory index tree' (duration: 107.042928ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:25:07.934088Z","caller":"traceutil/trace.go:171","msg":"trace[2036033918] transaction","detail":"{read_only:false; response_revision:27447; number_of_response:1; }","duration":"161.703329ms","start":"2026-10-17T12:25:07.77236Z","end":"2026-10-17T12:25:07.934064Z","steps":["trace[2036033918] 'process raft request' (duration: 152.004402ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:25:08.083393Z","caller":"traceutil/trace.go:171","msg":"trace[229087139] transaction","detail":"{read_only:false; response_revision:27448; number_of_response:1; }","duration":"145.318275ms","start":"2026-10-17T12:25:07.938046Z","end":"2026-10-17T12:25:08.083364Z","steps":["trace[229087139] 'process raft request' (duration: 124.374194ms)","trace[229087139] 'compare' (duration: 20.742256ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:25:08.083556Z","caller":"traceutil/trace.go:171","msg":"trace[733074498] linearizableReadLoop","detail":"{readStateIndex:28344; appliedIndex:28342; }","duration":"115.128318ms","start":"2026-10-17T12:25:07.968381Z","end":"2026-10-17T12:25:08.083509Z","steps":["trace[733074498] 'read index received' (duration: 94.061415ms)","trace[733074498] 'applied index is now lower than readState.Index' (duration: 21.065913ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T12:25:08.083624Z","caller":"traceutil/trace.go:171","msg":"trace[1911082246] transaction","detail":"{read_only:false; response_revision:27449; number_of_response:1; }","duration":"142.364936ms","start":"2026-10-17T12:25:07.941234Z","end":"2026-10-17T12:25:08.083599Z","steps":["trace[1911082246] 'process raft request' (duration: 142.08735ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:25:08.083799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.394365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T12:25:08.083841Z","caller":"traceutil/trace.go:171","msg":"trace[1615097308] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:27449; }","duration":"115.496707ms","start":"2026-10-17T12:25:07.968333Z","end":"2026-10-17T12:25:08.08383Z","steps":["trace[1615097308] 'agreement among raft nodes before linearized reading' (duration: 115.332423ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:25:08.083923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.437475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T12:25:08.083973Z","caller":"traceutil/trace.go:171","msg":"trace[2072934894] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:27449; }","duration":"115.542068ms","start":"2026-10-17T12:25:07.968419Z","end":"2026-10-17T12:25:08.083962Z","steps":["trace[2072934894] 'agreement among raft nodes before linearized reading' (duration: 115.423995ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:25:08.084068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.601349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T12:25:08.084095Z","caller":"traceutil/trace.go:171","msg":"trace[1272309873] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:27449; }","duration":"115.64101ms","start":"2026-10-17T12:25:07.968447Z","end":"2026-10-17T12:25:08.084088Z","steps":["trace[1272309873] 'agreement among raft nodes before linearized reading' (duration: 115.603389ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T12:25:08.084089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.366862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5080"} {"level":"info","ts":"2026-10-17T12:25:08.08413Z","caller":"traceutil/trace.go:171","msg":"trace[1453920964] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:27449; }","duration":"109.438235ms","start":"2026-10-17T12:25:07.974681Z","end":"2026-10-17T12:25:08.084119Z","steps":["trace[1453920964] 'agreement among raft nodes before linearized reading' (duration: 109.272521ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:25:31.98177Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24784} {"level":"info","ts":"2026-10-17T12:25:32.141197Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24784,"took":"150.540658ms","hash":37164248,"current-db-size-bytes":56479744,"current-db-size":"56 MB","current-db-size-in-use-bytes":36257792,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-10-17T12:25:32.141274Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":37164248,"revision":24784,"compact-revision":21722} {"level":"info","ts":"2026-10-17T12:27:59.136957Z","caller":"traceutil/trace.go:171","msg":"trace[637407357] transaction","detail":"{read_only:false; response_revision:29045; number_of_response:1; }","duration":"105.183105ms","start":"2026-10-17T12:27:59.031727Z","end":"2026-10-17T12:27:59.13691Z","steps":["trace[637407357] 'process raft request' (duration: 102.535583ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:28:02.842448Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"9755887b76c83964","local-member-applied-index":30006,"local-member-snapshot-index":20005,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T12:28:02.848795Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30006} {"level":"info","ts":"2026-10-17T12:28:02.848892Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25006} {"level":"info","ts":"2026-10-17T12:28:11.102363Z","caller":"traceutil/trace.go:171","msg":"trace[14528088] transaction","detail":"{read_only:false; response_revision:29136; number_of_response:1; }","duration":"113.049059ms","start":"2026-10-17T12:28:10.989277Z","end":"2026-10-17T12:28:11.102326Z","steps":["trace[14528088] 'process raft request' (duration: 112.847464ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T12:30:31.996104Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27635} {"level":"info","ts":"2026-10-17T12:30:32.138126Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27635,"took":"137.980053ms","hash":3530506259,"current-db-size-bytes":56479744,"current-db-size":"56 MB","current-db-size-in-use-bytes":34811904,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-10-17T12:30:32.138237Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3530506259,"revision":27635,"compact-revision":24784} {"level":"info","ts":"2026-10-17T12:35:32.004106Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30337} {"level":"info","ts":"2026-10-17T12:35:32.166308Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30337,"took":"157.732884ms","hash":2146053409,"current-db-size-bytes":56479744,"current-db-size":"56 MB","current-db-size-in-use-bytes":30875648,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-17T12:35:32.16638Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2146053409,"revision":30337,"compact-revision":27635} {"level":"info","ts":"2026-10-17T12:40:32.012343Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32585} {"level":"info","ts":"2026-10-17T12:40:32.171596Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32585,"took":"152.688986ms","hash":2443284589,"current-db-size-bytes":56479744,"current-db-size":"56 MB","current-db-size-in-use-bytes":30568448,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-17T12:40:32.171669Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2443284589,"revision":32585,"compact-revision":30337} {"level":"info","ts":"2026-10-17T12:45:32.021532Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34816} {"level":"info","ts":"2026-10-17T12:45:32.156728Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34816,"took":"130.24194ms","hash":1284871452,"current-db-size-bytes":56479744,"current-db-size":"56 MB","current-db-size-in-use-bytes":31924224,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-17T12:45:32.156811Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1284871452,"revision":34816,"compact-revision":32585} {"level":"info","ts":"2026-10-17T12:49:17.701794Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"9755887b76c83964","local-member-applied-index":40007,"local-member-snapshot-index":30006,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T12:49:17.707863Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40007} {"level":"info","ts":"2026-10-17T12:49:17.707965Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35007} {"level":"info","ts":"2026-10-17T12:50:32.034248Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37109} {"level":"info","ts":"2026-10-17T12:50:32.185899Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37109,"took":"144.826208ms","hash":46498071,"current-db-size-bytes":56479744,"current-db-size":"56 MB","current-db-size-in-use-bytes":32305152,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-17T12:50:32.185999Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":46498071,"revision":37109,"compact-revision":34816} {"level":"info","ts":"2026-10-17T12:55:32.04209Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39382} {"level":"info","ts":"2026-10-17T12:55:32.180713Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39382,"took":"134.774065ms","hash":981842023,"current-db-size-bytes":56901632,"current-db-size":"57 MB","current-db-size-in-use-bytes":32288768,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-17T12:55:32.180787Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":981842023,"revision":39382,"compact-revision":37109}