{"level":"warn","ts":"2026-10-17T03:08:59.2225Z","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-17T03:08:59.22265Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.57: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.57:2380","--initial-cluster=instance=https://162.253.55.57:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.57:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.57: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-17T03:08:59.222771Z","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-17T03:08:59.222797Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.57:2380"]} {"level":"info","ts":"2026-10-17T03:08:59.222834Z","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-17T03:08:59.224169Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.57:2379"]} {"level":"info","ts":"2026-10-17T03:08:59.224306Z","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.57:2380"],"listen-peer-urls":["https://162.253.55.57:2380"],"advertise-client-urls":["https://162.253.55.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.57: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-17T03:08:59.227454Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.759854ms"} {"level":"info","ts":"2026-10-17T03:08:59.240099Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"db28a37eabf8270","cluster-id":"33328f64ab44b15e"} {"level":"info","ts":"2026-10-17T03:08:59.240231Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 switched to configuration voters=()"} {"level":"info","ts":"2026-10-17T03:08:59.240264Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 became follower at term 0"} {"level":"info","ts":"2026-10-17T03:08:59.240282Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft db28a37eabf8270 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-17T03:08:59.240302Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 became follower at term 1"} {"level":"info","ts":"2026-10-17T03:08:59.240358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 switched to configuration voters=(987003241113813616)"} {"level":"warn","ts":"2026-10-17T03:08:59.247953Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-17T03:08:59.249981Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-17T03:08:59.251661Z","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-17T03:08:59.254887Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"db28a37eabf8270","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-17T03:08:59.25551Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"db28a37eabf8270","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-17T03:08:59.255666Z","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-17T03:08:59.255761Z","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-17T03:08:59.255774Z","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-17T03:08:59.258055Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 switched to configuration voters=(987003241113813616)"} {"level":"info","ts":"2026-10-17T03:08:59.258767Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"33328f64ab44b15e","local-member-id":"db28a37eabf8270","added-peer-id":"db28a37eabf8270","added-peer-peer-urls":["https://162.253.55.57:2380"]} {"level":"info","ts":"2026-10-17T03:08:59.260662Z","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-17T03:08:59.260896Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.57:2380"} {"level":"info","ts":"2026-10-17T03:08:59.260947Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-17T03:08:59.260963Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.57:2380"} {"level":"info","ts":"2026-10-17T03:08:59.260905Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"db28a37eabf8270","initial-advertise-peer-urls":["https://162.253.55.57:2380"],"listen-peer-urls":["https://162.253.55.57:2380"],"advertise-client-urls":["https://162.253.55.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-17T03:08:59.841367Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 is starting a new election at term 1"} {"level":"info","ts":"2026-10-17T03:08:59.841428Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-17T03:08:59.841451Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 received MsgPreVoteResp from db28a37eabf8270 at term 1"} {"level":"info","ts":"2026-10-17T03:08:59.841469Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 became candidate at term 2"} {"level":"info","ts":"2026-10-17T03:08:59.841481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 received MsgVoteResp from db28a37eabf8270 at term 2"} {"level":"info","ts":"2026-10-17T03:08:59.841495Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 became leader at term 2"} {"level":"info","ts":"2026-10-17T03:08:59.841508Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: db28a37eabf8270 elected leader db28a37eabf8270 at term 2"} {"level":"info","ts":"2026-10-17T03:08:59.84288Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T03:08:59.843724Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-17T03:08:59.843714Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"db28a37eabf8270","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.57:2379]}","request-path":"/0/members/db28a37eabf8270/attributes","cluster-id":"33328f64ab44b15e","publish-timeout":"7s"} {"level":"info","ts":"2026-10-17T03:08:59.843783Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-17T03:08:59.844114Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-17T03:08:59.844186Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-17T03:08:59.844494Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"33328f64ab44b15e","local-member-id":"db28a37eabf8270","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T03:08:59.844646Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T03:08:59.844681Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T03:08:59.846939Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-17T03:08:59.847035Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.57:2379"} {"level":"info","ts":"2026-10-17T03:09:49.875748Z","caller":"traceutil/trace.go:171","msg":"trace[1552058396] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"104.593133ms","start":"2026-10-17T03:09:49.771121Z","end":"2026-10-17T03:09:49.875714Z","steps":["trace[1552058396] 'process raft request' (duration: 104.010627ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:09:50.369875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.111689ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T03:09:50.370109Z","caller":"traceutil/trace.go:171","msg":"trace[911340234] linearizableReadLoop","detail":"{readStateIndex:671; appliedIndex:669; }","duration":"342.826966ms","start":"2026-10-17T03:09:50.027261Z","end":"2026-10-17T03:09:50.370088Z","steps":["trace[911340234] 'read index received' (duration: 168.895955ms)","trace[911340234] 'applied index is now lower than readState.Index' (duration: 173.929761ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T03:09:50.370221Z","caller":"traceutil/trace.go:171","msg":"trace[958069822] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"427.066982ms","start":"2026-10-17T03:09:49.943116Z","end":"2026-10-17T03:09:50.370183Z","steps":["trace[958069822] 'process raft request' (duration: 252.968557ms)","trace[958069822] 'compare' (duration: 172.948214ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T03:09:50.370253Z","caller":"traceutil/trace.go:171","msg":"trace[237153223] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"411.972978ms","start":"2026-10-17T03:09:49.958244Z","end":"2026-10-17T03:09:50.370217Z","steps":["trace[237153223] 'process raft request' (duration: 411.760782ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:09:50.370285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.049972ms","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-17T03:09:50.370329Z","caller":"traceutil/trace.go:171","msg":"trace[1503013930] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:646; }","duration":"343.138854ms","start":"2026-10-17T03:09:50.02718Z","end":"2026-10-17T03:09:50.370318Z","steps":["trace[1503013930] 'agreement among raft nodes before linearized reading' (duration: 342.97709ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:09:50.370371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T03:09:50.02716Z","time spent":"343.201516ms","remote":"127.0.0.1:40580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-10-17T03:09:50.370408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T03:09:49.958226Z","time spent":"412.097602ms","remote":"127.0.0.1:40646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-17T03:09:50.370436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T03:09:49.943089Z","time spent":"427.221847ms","remote":"127.0.0.1:40580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T03:11:22.601756Z","caller":"traceutil/trace.go:171","msg":"trace[378122077] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"109.037429ms","start":"2026-10-17T03:11:22.492695Z","end":"2026-10-17T03:11:22.601732Z","steps":["trace[378122077] 'process raft request' (duration: 108.818543ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:11:22.601758Z","caller":"traceutil/trace.go:171","msg":"trace[100477841] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"191.00097ms","start":"2026-10-17T03:11:22.410736Z","end":"2026-10-17T03:11:22.601737Z","steps":["trace[100477841] 'process raft request' (duration: 190.696282ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:11:22.602375Z","caller":"traceutil/trace.go:171","msg":"trace[753608114] transaction","detail":"{read_only:false; response_revision:1887; number_of_response:1; }","duration":"320.328086ms","start":"2026-10-17T03:11:22.281478Z","end":"2026-10-17T03:11:22.601806Z","steps":["trace[753608114] 'process raft request' (duration: 277.47594ms)","trace[753608114] 'compare' (duration: 42.274631ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T03:11:22.602588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T03:11:22.281458Z","time spent":"320.982054ms","remote":"127.0.0.1:40580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T03:11:22.993403Z","caller":"traceutil/trace.go:171","msg":"trace[172604245] linearizableReadLoop","detail":"{readStateIndex:1965; appliedIndex:1964; }","duration":"157.123502ms","start":"2026-10-17T03:11:22.836257Z","end":"2026-10-17T03:11:22.99338Z","steps":["trace[172604245] 'read index received' (duration: 156.896986ms)","trace[172604245] 'applied index is now lower than readState.Index' (duration: 225.436µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T03:11:22.993466Z","caller":"traceutil/trace.go:171","msg":"trace[356606674] transaction","detail":"{read_only:false; response_revision:1890; number_of_response:1; }","duration":"187.273931ms","start":"2026-10-17T03:11:22.806151Z","end":"2026-10-17T03:11:22.993425Z","steps":["trace[356606674] 'process raft request' (duration: 187.057466ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:11:22.993629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.356579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T03:11:22.993721Z","caller":"traceutil/trace.go:171","msg":"trace[1172344809] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:1890; }","duration":"157.484972ms","start":"2026-10-17T03:11:22.836217Z","end":"2026-10-17T03:11:22.993702Z","steps":["trace[1172344809] 'agreement among raft nodes before linearized reading' (duration: 157.293427ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:11:22.993746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.220981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5700"} {"level":"info","ts":"2026-10-17T03:11:22.993832Z","caller":"traceutil/trace.go:171","msg":"trace[83496475] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1890; }","duration":"138.340085ms","start":"2026-10-17T03:11:22.855472Z","end":"2026-10-17T03:11:22.993812Z","steps":["trace[83496475] 'agreement among raft nodes before linearized reading' (duration: 138.091858ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:11:22.993992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.936993ms","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-17T03:11:22.994064Z","caller":"traceutil/trace.go:171","msg":"trace[374305809] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1890; }","duration":"110.063926ms","start":"2026-10-17T03:11:22.883978Z","end":"2026-10-17T03:11:22.994042Z","steps":["trace[374305809] 'agreement among raft nodes before linearized reading' (duration: 109.878021ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:11:35.244941Z","caller":"traceutil/trace.go:171","msg":"trace[791171205] linearizableReadLoop","detail":"{readStateIndex:2071; appliedIndex:2070; }","duration":"124.420076ms","start":"2026-10-17T03:11:35.120497Z","end":"2026-10-17T03:11:35.244917Z","steps":["trace[791171205] 'read index received' (duration: 124.239131ms)","trace[791171205] 'applied index is now lower than readState.Index' (duration: 179.625µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T03:11:35.245053Z","caller":"traceutil/trace.go:171","msg":"trace[1180181990] transaction","detail":"{read_only:false; response_revision:1993; number_of_response:1; }","duration":"124.829237ms","start":"2026-10-17T03:11:35.120199Z","end":"2026-10-17T03:11:35.245029Z","steps":["trace[1180181990] 'process raft request' (duration: 124.55404ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:11:35.24521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.691183ms","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-17T03:11:35.245256Z","caller":"traceutil/trace.go:171","msg":"trace[29015894] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1993; }","duration":"124.770866ms","start":"2026-10-17T03:11:35.120472Z","end":"2026-10-17T03:11:35.245243Z","steps":["trace[29015894] 'agreement among raft nodes before linearized reading' (duration: 124.601701ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:11:35.245334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.867441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5700"} {"level":"info","ts":"2026-10-17T03:11:35.245427Z","caller":"traceutil/trace.go:171","msg":"trace[1180214624] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1993; }","duration":"109.943733ms","start":"2026-10-17T03:11:35.135428Z","end":"2026-10-17T03:11:35.245372Z","steps":["trace[1180214624] 'agreement among raft nodes before linearized reading' (duration: 109.758528ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:11:35.245312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.205911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-17T03:11:35.24575Z","caller":"traceutil/trace.go:171","msg":"trace[636670232] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1993; }","duration":"121.659183ms","start":"2026-10-17T03:11:35.124055Z","end":"2026-10-17T03:11:35.245715Z","steps":["trace[636670232] 'agreement among raft nodes before linearized reading' (duration: 121.041577ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:13:38.018602Z","caller":"traceutil/trace.go:171","msg":"trace[1475129976] transaction","detail":"{read_only:false; response_revision:2866; number_of_response:1; }","duration":"139.148422ms","start":"2026-10-17T03:13:37.879421Z","end":"2026-10-17T03:13:38.01857Z","steps":["trace[1475129976] 'process raft request' (duration: 81.343622ms)","trace[1475129976] 'compare' (duration: 57.536622ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T03:16:45.17559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.668181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-17T03:16:45.17569Z","caller":"traceutil/trace.go:171","msg":"trace[97007485] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4055; }","duration":"110.821775ms","start":"2026-10-17T03:16:45.064849Z","end":"2026-10-17T03:16:45.17567Z","steps":["trace[97007485] 'range keys from in-memory index tree' (duration: 110.481926ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:16:45.17572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.013156ms","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-17T03:16:45.175754Z","caller":"traceutil/trace.go:171","msg":"trace[1741092501] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4055; }","duration":"106.070537ms","start":"2026-10-17T03:16:45.069676Z","end":"2026-10-17T03:16:45.175746Z","steps":["trace[1741092501] 'range keys from in-memory index tree' (duration: 105.936584ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:16:45.17595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.28618ms","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-17T03:16:45.175985Z","caller":"traceutil/trace.go:171","msg":"trace[786074137] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4055; }","duration":"133.350882ms","start":"2026-10-17T03:16:45.042624Z","end":"2026-10-17T03:16:45.175975Z","steps":["trace[786074137] 'range keys from in-memory index tree' (duration: 133.191977ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:18:13.26298Z","caller":"traceutil/trace.go:171","msg":"trace[550960014] transaction","detail":"{read_only:false; response_revision:5101; number_of_response:1; }","duration":"173.740546ms","start":"2026-10-17T03:18:13.089204Z","end":"2026-10-17T03:18:13.262944Z","steps":["trace[550960014] 'process raft request' (duration: 173.473379ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:18:18.278153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.33256ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-17T03:18:18.278344Z","caller":"traceutil/trace.go:171","msg":"trace[1625428011] transaction","detail":"{read_only:false; response_revision:5272; number_of_response:1; }","duration":"273.562812ms","start":"2026-10-17T03:18:18.004753Z","end":"2026-10-17T03:18:18.278316Z","steps":["trace[1625428011] 'process raft request' (duration: 113.985335ms)","trace[1625428011] 'compare' (duration: 159.185377ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T03:18:18.32147Z","caller":"traceutil/trace.go:171","msg":"trace[689998134] linearizableReadLoop","detail":"{readStateIndex:5475; appliedIndex:5472; }","duration":"270.151841ms","start":"2026-10-17T03:18:18.051294Z","end":"2026-10-17T03:18:18.321446Z","steps":["trace[689998134] 'read index received' (duration: 67.443528ms)","trace[689998134] 'applied index is now lower than readState.Index' (duration: 202.707183ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T03:18:18.321775Z","caller":"traceutil/trace.go:171","msg":"trace[401981264] transaction","detail":"{read_only:false; response_revision:5273; number_of_response:1; }","duration":"314.352875ms","start":"2026-10-17T03:18:18.00741Z","end":"2026-10-17T03:18:18.321762Z","steps":["trace[401981264] 'process raft request' (duration: 313.867942ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:18:18.321874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T03:18:18.007374Z","time spent":"314.434768ms","remote":"127.0.0.1:40762","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5068,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T03:18:18.322084Z","caller":"traceutil/trace.go:171","msg":"trace[1312994647] transaction","detail":"{read_only:false; response_revision:5274; number_of_response:1; }","duration":"313.334728ms","start":"2026-10-17T03:18:18.008739Z","end":"2026-10-17T03:18:18.322073Z","steps":["trace[1312994647] 'process raft request' (duration: 312.65885ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:18:18.322142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T03:18:18.008719Z","time spent":"313.39274ms","remote":"127.0.0.1:40488","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4934,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T03:18:18.322554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.362189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12430"} {"level":"info","ts":"2026-10-17T03:18:18.322614Z","caller":"traceutil/trace.go:171","msg":"trace[1264710503] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5274; }","duration":"266.490283ms","start":"2026-10-17T03:18:18.056107Z","end":"2026-10-17T03:18:18.322598Z","steps":["trace[1264710503] 'agreement among raft nodes before linearized reading' (duration: 266.277437ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:18:18.322634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.342862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:787349"} {"level":"info","ts":"2026-10-17T03:18:18.322679Z","caller":"traceutil/trace.go:171","msg":"trace[922657783] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5274; }","duration":"271.451006ms","start":"2026-10-17T03:18:18.051215Z","end":"2026-10-17T03:18:18.322666Z","steps":["trace[922657783] 'agreement among raft nodes before linearized reading' (duration: 271.048055ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:18:18.323006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.60945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-653b09dd-1a6c-4071-a77f-d1e6b4b8ce09\" ","response":"range_response_count:1 size:3600"} {"level":"info","ts":"2026-10-17T03:18:18.323052Z","caller":"traceutil/trace.go:171","msg":"trace[1336067458] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-653b09dd-1a6c-4071-a77f-d1e6b4b8ce09; range_end:; response_count:1; response_revision:5274; }","duration":"199.675552ms","start":"2026-10-17T03:18:18.123364Z","end":"2026-10-17T03:18:18.32304Z","steps":["trace[1336067458] 'agreement among raft nodes before linearized reading' (duration: 199.558238ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:18:18.323421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.031739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-sjtsh\" ","response":"range_response_count:1 size:6526"} {"level":"info","ts":"2026-10-17T03:18:18.323471Z","caller":"traceutil/trace.go:171","msg":"trace[1704860424] range","detail":"{range_begin:/registry/pods/openstack/keepalived-sjtsh; range_end:; response_count:1; response_revision:5274; }","duration":"213.120652ms","start":"2026-10-17T03:18:18.110337Z","end":"2026-10-17T03:18:18.323457Z","steps":["trace[1704860424] 'agreement among raft nodes before linearized reading' (duration: 212.985498ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:18:32.537021Z","caller":"traceutil/trace.go:171","msg":"trace[1361239167] transaction","detail":"{read_only:false; response_revision:5532; number_of_response:1; }","duration":"111.000026ms","start":"2026-10-17T03:18:32.425994Z","end":"2026-10-17T03:18:32.536994Z","steps":["trace[1361239167] 'process raft request' (duration: 36.502059ms)","trace[1361239167] 'compare' (duration: 74.201879ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T03:18:32.577372Z","caller":"traceutil/trace.go:171","msg":"trace[1290349062] linearizableReadLoop","detail":"{readStateIndex:5742; appliedIndex:5740; }","duration":"128.33182ms","start":"2026-10-17T03:18:32.449018Z","end":"2026-10-17T03:18:32.577349Z","steps":["trace[1290349062] 'read index received' (duration: 13.465122ms)","trace[1290349062] 'applied index is now lower than readState.Index' (duration: 114.865608ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T03:18:32.577433Z","caller":"traceutil/trace.go:171","msg":"trace[1494085676] transaction","detail":"{read_only:false; response_revision:5533; number_of_response:1; }","duration":"150.849303ms","start":"2026-10-17T03:18:32.426551Z","end":"2026-10-17T03:18:32.5774Z","steps":["trace[1494085676] 'process raft request' (duration: 150.694479ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:18:32.577601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.572356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-sjtsh\" ","response":"range_response_count:1 size:6526"} {"level":"info","ts":"2026-10-17T03:18:32.577641Z","caller":"traceutil/trace.go:171","msg":"trace[970409128] range","detail":"{range_begin:/registry/pods/openstack/keepalived-sjtsh; range_end:; response_count:1; response_revision:5533; }","duration":"128.624768ms","start":"2026-10-17T03:18:32.449005Z","end":"2026-10-17T03:18:32.57763Z","steps":["trace[970409128] 'agreement among raft nodes before linearized reading' (duration: 128.470323ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:18:40.361359Z","caller":"traceutil/trace.go:171","msg":"trace[1061686394] transaction","detail":"{read_only:false; response_revision:5707; number_of_response:1; }","duration":"112.455694ms","start":"2026-10-17T03:18:40.248873Z","end":"2026-10-17T03:18:40.361329Z","steps":["trace[1061686394] 'process raft request' (duration: 111.960821ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:18:40.360994Z","caller":"traceutil/trace.go:171","msg":"trace[593600229] transaction","detail":"{read_only:false; response_revision:5706; number_of_response:1; }","duration":"112.433444ms","start":"2026-10-17T03:18:40.248508Z","end":"2026-10-17T03:18:40.360941Z","steps":["trace[593600229] 'process raft request' (duration: 104.44847ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:18:40.361727Z","caller":"traceutil/trace.go:171","msg":"trace[84042018] transaction","detail":"{read_only:false; response_revision:5709; number_of_response:1; }","duration":"112.345201ms","start":"2026-10-17T03:18:40.24934Z","end":"2026-10-17T03:18:40.361685Z","steps":["trace[84042018] 'process raft request' (duration: 112.120385ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:18:40.361869Z","caller":"traceutil/trace.go:171","msg":"trace[664668395] transaction","detail":"{read_only:false; response_revision:5708; number_of_response:1; }","duration":"112.657169ms","start":"2026-10-17T03:18:40.249187Z","end":"2026-10-17T03:18:40.361844Z","steps":["trace[664668395] 'process raft request' (duration: 112.083474ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:18:40.361918Z","caller":"traceutil/trace.go:171","msg":"trace[1876824068] transaction","detail":"{read_only:false; response_revision:5710; number_of_response:1; }","duration":"111.482807ms","start":"2026-10-17T03:18:40.250416Z","end":"2026-10-17T03:18:40.361899Z","steps":["trace[1876824068] 'process raft request' (duration: 111.130028ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:18:40.361961Z","caller":"traceutil/trace.go:171","msg":"trace[1222317136] linearizableReadLoop","detail":"{readStateIndex:5920; appliedIndex:5918; }","duration":"113.355278ms","start":"2026-10-17T03:18:40.248565Z","end":"2026-10-17T03:18:40.36192Z","steps":["trace[1222317136] 'read index received' (duration: 69.605585ms)","trace[1222317136] 'applied index is now lower than readState.Index' (duration: 43.747983ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T03:18:40.362308Z","caller":"traceutil/trace.go:171","msg":"trace[1320358185] transaction","detail":"{read_only:false; response_revision:5711; number_of_response:1; }","duration":"109.280509ms","start":"2026-10-17T03:18:40.253007Z","end":"2026-10-17T03:18:40.362287Z","steps":["trace[1320358185] 'process raft request' (duration: 108.609581ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:18:40.362404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.652376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-653b09dd-1a6c-4071-a77f-d1e6b4b8ce09\" ","response":"range_response_count:1 size:1275"} {"level":"info","ts":"2026-10-17T03:18:40.362485Z","caller":"traceutil/trace.go:171","msg":"trace[1850438491] range","detail":"{range_begin:/registry/persistentvolumes/pvc-653b09dd-1a6c-4071-a77f-d1e6b4b8ce09; range_end:; response_count:1; response_revision:5711; }","duration":"113.76738ms","start":"2026-10-17T03:18:40.248696Z","end":"2026-10-17T03:18:40.362463Z","steps":["trace[1850438491] 'agreement among raft nodes before linearized reading' (duration: 113.528013ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:18:40.362484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.869992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/loki-chunks-cache-0\" ","response":"range_response_count:1 size:4463"} {"level":"info","ts":"2026-10-17T03:18:40.362557Z","caller":"traceutil/trace.go:171","msg":"trace[1705380915] range","detail":"{range_begin:/registry/pods/monitoring/loki-chunks-cache-0; range_end:; response_count:1; response_revision:5711; }","duration":"114.051497ms","start":"2026-10-17T03:18:40.248492Z","end":"2026-10-17T03:18:40.362543Z","steps":["trace[1705380915] 'agreement among raft nodes before linearized reading' (duration: 113.79333ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:18:40.509285Z","caller":"traceutil/trace.go:171","msg":"trace[1379420302] transaction","detail":"{read_only:false; response_revision:5712; number_of_response:1; }","duration":"135.875492ms","start":"2026-10-17T03:18:40.373374Z","end":"2026-10-17T03:18:40.50925Z","steps":["trace[1379420302] 'process raft request' (duration: 115.011913ms)","trace[1379420302] 'compare' (duration: 20.714345ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T03:18:52.762466Z","caller":"traceutil/trace.go:171","msg":"trace[669387786] transaction","detail":"{read_only:false; response_revision:5849; number_of_response:1; }","duration":"123.586982ms","start":"2026-10-17T03:18:52.638841Z","end":"2026-10-17T03:18:52.762428Z","steps":["trace[669387786] 'process raft request' (duration: 84.150835ms)","trace[669387786] 'compare' (duration: 38.980615ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T03:18:59.895779Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2988} {"level":"info","ts":"2026-10-17T03:18:59.984552Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2988,"took":"87.002002ms","hash":2100528997,"current-db-size-bytes":56299520,"current-db-size":"56 MB","current-db-size-in-use-bytes":32460800,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-17T03:18:59.984623Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2100528997,"revision":2988,"compact-revision":-1} {"level":"info","ts":"2026-10-17T03:23:59.902711Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5909} {"level":"info","ts":"2026-10-17T03:23:59.996915Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5909,"took":"92.260124ms","hash":3882795480,"current-db-size-bytes":56299520,"current-db-size":"56 MB","current-db-size-in-use-bytes":26533888,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-17T03:23:59.996985Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3882795480,"revision":5909,"compact-revision":2988} {"level":"info","ts":"2026-10-17T03:25:05.04095Z","caller":"traceutil/trace.go:171","msg":"trace[1760427737] transaction","detail":"{read_only:false; response_revision:8624; number_of_response:1; }","duration":"110.617088ms","start":"2026-10-17T03:25:04.930306Z","end":"2026-10-17T03:25:05.040923Z","steps":["trace[1760427737] 'process raft request' (duration: 110.444694ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:25:05.105609Z","caller":"traceutil/trace.go:171","msg":"trace[2038783258] transaction","detail":"{read_only:false; response_revision:8625; number_of_response:1; }","duration":"160.496241ms","start":"2026-10-17T03:25:04.945078Z","end":"2026-10-17T03:25:05.105574Z","steps":["trace[2038783258] 'process raft request' (duration: 160.316956ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:25:17.313611Z","caller":"traceutil/trace.go:171","msg":"trace[303241513] linearizableReadLoop","detail":"{readStateIndex:8998; appliedIndex:8997; }","duration":"216.889749ms","start":"2026-10-17T03:25:17.096697Z","end":"2026-10-17T03:25:17.313587Z","steps":["trace[303241513] 'read index received' (duration: 216.723604ms)","trace[303241513] 'applied index is now lower than readState.Index' (duration: 165.675µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T03:25:17.313717Z","caller":"traceutil/trace.go:171","msg":"trace[363349120] transaction","detail":"{read_only:false; response_revision:8688; number_of_response:1; }","duration":"236.180878ms","start":"2026-10-17T03:25:17.077505Z","end":"2026-10-17T03:25:17.313686Z","steps":["trace[363349120] 'process raft request' (duration: 235.960263ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:25:17.313768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.066624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-10-17T03:25:17.313795Z","caller":"traceutil/trace.go:171","msg":"trace[2124732508] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8688; }","duration":"217.134596ms","start":"2026-10-17T03:25:17.096652Z","end":"2026-10-17T03:25:17.313787Z","steps":["trace[2124732508] 'agreement among raft nodes before linearized reading' (duration: 217.035964ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:25:17.313873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.908826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-sjtsh\" ","response":"range_response_count:1 size:6526"} {"level":"info","ts":"2026-10-17T03:25:17.313937Z","caller":"traceutil/trace.go:171","msg":"trace[1242927914] range","detail":"{range_begin:/registry/pods/openstack/keepalived-sjtsh; range_end:; response_count:1; response_revision:8688; }","duration":"137.007179ms","start":"2026-10-17T03:25:17.176908Z","end":"2026-10-17T03:25:17.313915Z","steps":["trace[1242927914] 'agreement among raft nodes before linearized reading' (duration: 136.833744ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:25:18.222548Z","caller":"traceutil/trace.go:171","msg":"trace[1539502227] transaction","detail":"{read_only:false; response_revision:8695; number_of_response:1; }","duration":"175.31234ms","start":"2026-10-17T03:25:18.047202Z","end":"2026-10-17T03:25:18.222515Z","steps":["trace[1539502227] 'process raft request' (duration: 175.204747ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:25:23.583315Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002351.wal"} {"level":"warn","ts":"2026-10-17T03:25:46.361352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.336143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-17T03:25:46.361438Z","caller":"traceutil/trace.go:171","msg":"trace[824174579] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:8896; }","duration":"350.466855ms","start":"2026-10-17T03:25:46.010955Z","end":"2026-10-17T03:25:46.361422Z","steps":["trace[824174579] 'count revisions from in-memory index tree' (duration: 350.26866ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:25:46.361474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T03:25:46.010937Z","time spent":"350.528207ms","remote":"127.0.0.1:40706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":29,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-10-17T03:25:46.361841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.947574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-10-17T03:25:46.361873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.375401ms","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-17T03:25:46.361917Z","caller":"traceutil/trace.go:171","msg":"trace[1154386045] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8896; }","duration":"224.432922ms","start":"2026-10-17T03:25:46.137471Z","end":"2026-10-17T03:25:46.361904Z","steps":["trace[1154386045] 'range keys from in-memory index tree' (duration: 224.255878ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:25:46.361915Z","caller":"traceutil/trace.go:171","msg":"trace[1755927093] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8896; }","duration":"226.068457ms","start":"2026-10-17T03:25:46.135831Z","end":"2026-10-17T03:25:46.3619Z","steps":["trace[1755927093] 'range keys from in-memory index tree' (duration: 225.761128ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:25:46.362163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.245441ms","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-17T03:25:46.362193Z","caller":"traceutil/trace.go:171","msg":"trace[1516324802] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8896; }","duration":"278.308343ms","start":"2026-10-17T03:25:46.083876Z","end":"2026-10-17T03:25:46.362184Z","steps":["trace[1516324802] 'range keys from in-memory index tree' (duration: 278.145049ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:27:03.856239Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"db28a37eabf8270","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T03:27:03.864376Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-17T03:27:03.864525Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-10-17T03:27:26.86353Z","caller":"traceutil/trace.go:171","msg":"trace[1820967900] transaction","detail":"{read_only:false; response_revision:9811; number_of_response:1; }","duration":"119.354439ms","start":"2026-10-17T03:27:26.744152Z","end":"2026-10-17T03:27:26.863506Z","steps":["trace[1820967900] 'process raft request' (duration: 119.210355ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:28:59.9092Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8070} {"level":"info","ts":"2026-10-17T03:28:59.978423Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8070,"took":"66.970637ms","hash":649598049,"current-db-size-bytes":56299520,"current-db-size":"56 MB","current-db-size-in-use-bytes":28475392,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-17T03:28:59.978495Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":649598049,"revision":8070,"compact-revision":5909} {"level":"info","ts":"2026-10-17T03:33:59.916872Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10441} {"level":"info","ts":"2026-10-17T03:34:00.005816Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10441,"took":"86.366124ms","hash":2576067522,"current-db-size-bytes":56299520,"current-db-size":"56 MB","current-db-size-in-use-bytes":26333184,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-17T03:34:00.005906Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2576067522,"revision":10441,"compact-revision":8070} {"level":"info","ts":"2026-10-17T03:38:59.923771Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12614} {"level":"info","ts":"2026-10-17T03:39:00.01406Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12614,"took":"88.238393ms","hash":2469048491,"current-db-size-bytes":56299520,"current-db-size":"56 MB","current-db-size-in-use-bytes":27762688,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-17T03:39:00.014148Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2469048491,"revision":12614,"compact-revision":10441} {"level":"info","ts":"2026-10-17T03:39:18.132466Z","caller":"traceutil/trace.go:171","msg":"trace[1860043303] transaction","detail":"{read_only:false; response_revision:14761; number_of_response:1; }","duration":"102.10364ms","start":"2026-10-17T03:39:18.030334Z","end":"2026-10-17T03:39:18.132438Z","steps":["trace[1860043303] 'process raft request' (duration: 101.950456ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:39:38.213693Z","caller":"traceutil/trace.go:171","msg":"trace[1344382108] transaction","detail":"{read_only:false; response_revision:14862; number_of_response:1; }","duration":"164.405436ms","start":"2026-10-17T03:39:38.049254Z","end":"2026-10-17T03:39:38.21366Z","steps":["trace[1344382108] 'process raft request' (duration: 164.207961ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:39:38.34787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.401417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-10-17T03:39:38.347951Z","caller":"traceutil/trace.go:171","msg":"trace[1088168382] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14862; }","duration":"110.52665ms","start":"2026-10-17T03:39:38.237404Z","end":"2026-10-17T03:39:38.347931Z","steps":["trace[1088168382] 'range keys from in-memory index tree' (duration: 110.234161ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:39:46.97879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.994963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:356"} {"level":"info","ts":"2026-10-17T03:39:46.978929Z","caller":"traceutil/trace.go:171","msg":"trace[1160266990] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:14906; }","duration":"125.170149ms","start":"2026-10-17T03:39:46.853741Z","end":"2026-10-17T03:39:46.978911Z","steps":["trace[1160266990] 'range keys from in-memory index tree' (duration: 124.85311ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:39:46.97918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.58371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12430"} {"level":"info","ts":"2026-10-17T03:39:46.979957Z","caller":"traceutil/trace.go:171","msg":"trace[1872273113] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:14906; }","duration":"122.386703ms","start":"2026-10-17T03:39:46.857527Z","end":"2026-10-17T03:39:46.979913Z","steps":["trace[1872273113] 'range keys from in-memory index tree' (duration: 121.450588ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:39:55.381888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.342949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-10-17T03:39:55.381989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.10244ms","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-17T03:39:55.382076Z","caller":"traceutil/trace.go:171","msg":"trace[1133342014] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14961; }","duration":"167.257455ms","start":"2026-10-17T03:39:55.214799Z","end":"2026-10-17T03:39:55.382057Z","steps":["trace[1133342014] 'range keys from in-memory index tree' (duration: 166.935466ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:39:55.381898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.532125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T03:39:55.382259Z","caller":"traceutil/trace.go:171","msg":"trace[1939608909] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:14961; }","duration":"130.908915ms","start":"2026-10-17T03:39:55.251309Z","end":"2026-10-17T03:39:55.382218Z","steps":["trace[1939608909] 'count revisions from in-memory index tree' (duration: 130.462113ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:39:55.382048Z","caller":"traceutil/trace.go:171","msg":"trace[1385457669] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14961; }","duration":"166.530455ms","start":"2026-10-17T03:39:55.215498Z","end":"2026-10-17T03:39:55.382028Z","steps":["trace[1385457669] 'range keys from in-memory index tree' (duration: 166.216806ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:39:56.033994Z","caller":"traceutil/trace.go:171","msg":"trace[1212931759] transaction","detail":"{read_only:false; response_revision:14967; number_of_response:1; }","duration":"211.410827ms","start":"2026-10-17T03:39:55.822554Z","end":"2026-10-17T03:39:56.033965Z","steps":["trace[1212931759] 'process raft request' (duration: 211.220962ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:39:56.261262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.959325ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T03:39:56.261468Z","caller":"traceutil/trace.go:171","msg":"trace[482970891] transaction","detail":"{read_only:false; response_revision:14968; number_of_response:1; }","duration":"317.516897ms","start":"2026-10-17T03:39:55.943924Z","end":"2026-10-17T03:39:56.261441Z","steps":["trace[482970891] 'process raft request' (duration: 171.285964ms)","trace[482970891] 'compare' (duration: 145.836232ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T03:39:56.26162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T03:39:55.943902Z","time spent":"317.62403ms","remote":"127.0.0.1:40580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T03:40:19.954919Z","caller":"traceutil/trace.go:171","msg":"trace[1385031830] transaction","detail":"{read_only:false; response_revision:15287; number_of_response:1; }","duration":"105.100002ms","start":"2026-10-17T03:40:19.849781Z","end":"2026-10-17T03:40:19.954881Z","steps":["trace[1385031830] 'process raft request' (duration: 104.922538ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:40:19.955013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.135997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c81f13b8-fbac-4cc5-b599-63cfa5494d02\" ","response":"range_response_count:1 size:3636"} {"level":"info","ts":"2026-10-17T03:40:19.955085Z","caller":"traceutil/trace.go:171","msg":"trace[724448361] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c81f13b8-fbac-4cc5-b599-63cfa5494d02; range_end:; response_count:1; response_revision:15287; }","duration":"100.25243ms","start":"2026-10-17T03:40:19.854812Z","end":"2026-10-17T03:40:19.955065Z","steps":["trace[724448361] 'agreement among raft nodes before linearized reading' (duration: 100.021454ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:40:20.375739Z","caller":"traceutil/trace.go:171","msg":"trace[1361145855] transaction","detail":"{read_only:false; response_revision:15288; number_of_response:1; }","duration":"223.863417ms","start":"2026-10-17T03:40:20.151851Z","end":"2026-10-17T03:40:20.375714Z","steps":["trace[1361145855] 'process raft request' (duration: 223.639471ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:41:13.549401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.244291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-17T03:41:13.549463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.116907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T03:41:13.549522Z","caller":"traceutil/trace.go:171","msg":"trace[1464477903] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:15921; }","duration":"145.455267ms","start":"2026-10-17T03:41:13.40404Z","end":"2026-10-17T03:41:13.549495Z","steps":["trace[1464477903] 'count revisions from in-memory index tree' (duration: 145.126848ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:41:13.54954Z","caller":"traceutil/trace.go:171","msg":"trace[226340957] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:15921; }","duration":"145.232491ms","start":"2026-10-17T03:41:13.404288Z","end":"2026-10-17T03:41:13.549521Z","steps":["trace[226340957] 'count revisions from in-memory index tree' (duration: 145.069636ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:41:26.753992Z","caller":"traceutil/trace.go:171","msg":"trace[143458224] transaction","detail":"{read_only:false; response_revision:15994; number_of_response:1; }","duration":"118.881951ms","start":"2026-10-17T03:41:26.635082Z","end":"2026-10-17T03:41:26.753964Z","steps":["trace[143458224] 'process raft request' (duration: 118.698466ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:41:32.350924Z","caller":"traceutil/trace.go:171","msg":"trace[1342360975] transaction","detail":"{read_only:false; response_revision:16023; number_of_response:1; }","duration":"104.098012ms","start":"2026-10-17T03:41:32.246794Z","end":"2026-10-17T03:41:32.350892Z","steps":["trace[1342360975] 'process raft request' (duration: 79.948641ms)","trace[1342360975] 'compare' (duration: 23.787241ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T03:41:33.212908Z","caller":"traceutil/trace.go:171","msg":"trace[150070970] transaction","detail":"{read_only:false; response_revision:16026; number_of_response:1; }","duration":"271.952293ms","start":"2026-10-17T03:41:32.940922Z","end":"2026-10-17T03:41:33.212874Z","steps":["trace[150070970] 'process raft request' (duration: 271.771178ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:41:33.250723Z","caller":"traceutil/trace.go:171","msg":"trace[1718304545] transaction","detail":"{read_only:false; response_revision:16027; number_of_response:1; }","duration":"135.767365ms","start":"2026-10-17T03:41:33.11493Z","end":"2026-10-17T03:41:33.250697Z","steps":["trace[1718304545] 'process raft request' (duration: 135.587891ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:43:59.931282Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14617} {"level":"info","ts":"2026-10-17T03:44:00.024383Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14617,"took":"90.280011ms","hash":969577735,"current-db-size-bytes":56299520,"current-db-size":"56 MB","current-db-size-in-use-bytes":31109120,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-17T03:44:00.024461Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":969577735,"revision":14617,"compact-revision":12614} {"level":"info","ts":"2026-10-17T03:47:48.715959Z","caller":"traceutil/trace.go:171","msg":"trace[1275086173] transaction","detail":"{read_only:false; response_revision:18748; number_of_response:1; }","duration":"126.802382ms","start":"2026-10-17T03:47:48.589124Z","end":"2026-10-17T03:47:48.715926Z","steps":["trace[1275086173] 'process raft request' (duration: 126.641247ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:47:48.754217Z","caller":"traceutil/trace.go:171","msg":"trace[670708225] linearizableReadLoop","detail":"{readStateIndex:19395; appliedIndex:19393; }","duration":"102.082565ms","start":"2026-10-17T03:47:48.652109Z","end":"2026-10-17T03:47:48.754192Z","steps":["trace[670708225] 'read index received' (duration: 63.585746ms)","trace[670708225] 'applied index is now lower than readState.Index' (duration: 38.494298ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T03:47:48.754412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.302061ms","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-17T03:47:48.754453Z","caller":"traceutil/trace.go:171","msg":"trace[362445452] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18749; }","duration":"102.383823ms","start":"2026-10-17T03:47:48.652048Z","end":"2026-10-17T03:47:48.754431Z","steps":["trace[362445452] 'agreement among raft nodes before linearized reading' (duration: 102.25496ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:47:55.885477Z","caller":"traceutil/trace.go:171","msg":"trace[548869348] transaction","detail":"{read_only:false; response_revision:18787; number_of_response:1; }","duration":"110.78881ms","start":"2026-10-17T03:47:55.774659Z","end":"2026-10-17T03:47:55.885447Z","steps":["trace[548869348] 'process raft request' (duration: 65.520718ms)","trace[548869348] 'compare' (duration: 45.034016ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T03:47:56.242918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.440271ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T03:47:56.243031Z","caller":"traceutil/trace.go:171","msg":"trace[1180484137] linearizableReadLoop","detail":"{readStateIndex:19436; appliedIndex:19435; }","duration":"242.529645ms","start":"2026-10-17T03:47:56.000485Z","end":"2026-10-17T03:47:56.243014Z","steps":["trace[1180484137] 'read index received' (duration: 5.902479ms)","trace[1180484137] 'applied index is now lower than readState.Index' (duration: 236.625966ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T03:47:56.243192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.705801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-10-17T03:47:56.243227Z","caller":"traceutil/trace.go:171","msg":"trace[1350033798] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18788; }","duration":"242.801782ms","start":"2026-10-17T03:47:56.000414Z","end":"2026-10-17T03:47:56.243216Z","steps":["trace[1350033798] 'agreement among raft nodes before linearized reading' (duration: 242.645328ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:47:56.243091Z","caller":"traceutil/trace.go:171","msg":"trace[83832368] transaction","detail":"{read_only:false; response_revision:18788; number_of_response:1; }","duration":"254.93538ms","start":"2026-10-17T03:47:55.988091Z","end":"2026-10-17T03:47:56.243027Z","steps":["trace[83832368] 'process raft request' (duration: 18.289074ms)","trace[83832368] 'compare' (duration: 236.138843ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T03:47:56.603173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.036851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-z9lm8\" ","response":"range_response_count:1 size:22097"} {"level":"info","ts":"2026-10-17T03:47:56.603233Z","caller":"traceutil/trace.go:171","msg":"trace[1619581346] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-z9lm8; range_end:; response_count:1; response_revision:18791; }","duration":"126.156514ms","start":"2026-10-17T03:47:56.477062Z","end":"2026-10-17T03:47:56.603218Z","steps":["trace[1619581346] 'range keys from in-memory index tree' (duration: 125.873107ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:47:56.603656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.605699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T03:47:56.603678Z","caller":"traceutil/trace.go:171","msg":"trace[112458611] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:18791; }","duration":"225.66867ms","start":"2026-10-17T03:47:56.378003Z","end":"2026-10-17T03:47:56.603672Z","steps":["trace[112458611] 'count revisions from in-memory index tree' (duration: 225.511356ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:48:04.847901Z","caller":"traceutil/trace.go:171","msg":"trace[643930065] transaction","detail":"{read_only:false; number_of_response:1; response_revision:18912; }","duration":"104.024057ms","start":"2026-10-17T03:48:04.743859Z","end":"2026-10-17T03:48:04.847883Z","steps":["trace[643930065] 'process raft request' (duration: 103.976546ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:48:04.848098Z","caller":"traceutil/trace.go:171","msg":"trace[189797885] transaction","detail":"{read_only:false; response_revision:18912; number_of_response:1; }","duration":"104.720916ms","start":"2026-10-17T03:48:04.743312Z","end":"2026-10-17T03:48:04.848033Z","steps":["trace[189797885] 'process raft request' (duration: 104.428108ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:48:04.848427Z","caller":"traceutil/trace.go:171","msg":"trace[883310092] transaction","detail":"{read_only:false; number_of_response:1; response_revision:18912; }","duration":"103.462152ms","start":"2026-10-17T03:48:04.744933Z","end":"2026-10-17T03:48:04.848395Z","steps":["trace[883310092] 'process raft request' (duration: 102.922208ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:48:38.992455Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"db28a37eabf8270","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T03:48:39.002698Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-17T03:48:39.002823Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-10-17T03:48:59.940075Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17002} {"level":"info","ts":"2026-10-17T03:49:00.047641Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17002,"took":"101.104289ms","hash":3839577061,"current-db-size-bytes":56299520,"current-db-size":"56 MB","current-db-size-in-use-bytes":33091584,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-17T03:49:00.047704Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3839577061,"revision":17002,"compact-revision":14617} {"level":"info","ts":"2026-10-17T03:53:45.036789Z","caller":"traceutil/trace.go:171","msg":"trace[6446750] transaction","detail":"{read_only:false; response_revision:21486; number_of_response:1; }","duration":"102.702181ms","start":"2026-10-17T03:53:44.93406Z","end":"2026-10-17T03:53:45.036762Z","steps":["trace[6446750] 'process raft request' (duration: 102.504876ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:53:45.354987Z","caller":"traceutil/trace.go:171","msg":"trace[2025891734] transaction","detail":"{read_only:false; response_revision:21488; number_of_response:1; }","duration":"192.745012ms","start":"2026-10-17T03:53:45.162206Z","end":"2026-10-17T03:53:45.354951Z","steps":["trace[2025891734] 'process raft request' (duration: 192.505135ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:53:45.355432Z","caller":"traceutil/trace.go:171","msg":"trace[1201255511] transaction","detail":"{read_only:false; response_revision:21489; number_of_response:1; }","duration":"160.357678ms","start":"2026-10-17T03:53:45.195046Z","end":"2026-10-17T03:53:45.355404Z","steps":["trace[1201255511] 'process raft request' (duration: 159.859564ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:53:45.355947Z","caller":"traceutil/trace.go:171","msg":"trace[570416642] transaction","detail":"{read_only:false; response_revision:21490; number_of_response:1; }","duration":"159.121575ms","start":"2026-10-17T03:53:45.196757Z","end":"2026-10-17T03:53:45.355878Z","steps":["trace[570416642] 'process raft request' (duration: 158.550449ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:53:59.950947Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19499} {"level":"info","ts":"2026-10-17T03:54:00.104755Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19499,"took":"150.257905ms","hash":1562287525,"current-db-size-bytes":56299520,"current-db-size":"56 MB","current-db-size-in-use-bytes":29691904,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-17T03:54:00.104832Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1562287525,"revision":19499,"compact-revision":17002} {"level":"warn","ts":"2026-10-17T03:54:01.313032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.78589ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T03:54:01.313144Z","caller":"traceutil/trace.go:171","msg":"trace[1142681351] linearizableReadLoop","detail":"{readStateIndex:22310; appliedIndex:22309; }","duration":"101.110042ms","start":"2026-10-17T03:54:01.212016Z","end":"2026-10-17T03:54:01.313126Z","steps":["trace[1142681351] 'read index received' (duration: 79.923µs)","trace[1142681351] 'applied index is now lower than readState.Index' (duration: 101.028809ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T03:54:01.313227Z","caller":"traceutil/trace.go:171","msg":"trace[1400089071] transaction","detail":"{read_only:false; response_revision:21571; number_of_response:1; }","duration":"217.652101ms","start":"2026-10-17T03:54:01.095524Z","end":"2026-10-17T03:54:01.313176Z","steps":["trace[1400089071] 'process raft request' (duration: 32.626294ms)","trace[1400089071] 'compare' (duration: 184.624176ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T03:54:01.313274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.267135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1989"} {"level":"info","ts":"2026-10-17T03:54:01.313315Z","caller":"traceutil/trace.go:171","msg":"trace[61707716] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:21571; }","duration":"101.346678ms","start":"2026-10-17T03:54:01.211959Z","end":"2026-10-17T03:54:01.313306Z","steps":["trace[61707716] 'agreement among raft nodes before linearized reading' (duration: 101.212844ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:54:01.677689Z","caller":"traceutil/trace.go:171","msg":"trace[2228104] linearizableReadLoop","detail":"{readStateIndex:22311; appliedIndex:22310; }","duration":"248.199799ms","start":"2026-10-17T03:54:01.42945Z","end":"2026-10-17T03:54:01.67765Z","steps":["trace[2228104] 'read index received' (duration: 172.321602ms)","trace[2228104] 'applied index is now lower than readState.Index' (duration: 75.877057ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T03:54:01.677816Z","caller":"traceutil/trace.go:171","msg":"trace[138640471] transaction","detail":"{read_only:false; response_revision:21572; number_of_response:1; }","duration":"264.601925ms","start":"2026-10-17T03:54:01.413169Z","end":"2026-10-17T03:54:01.677771Z","steps":["trace[138640471] 'process raft request' (duration: 188.682606ms)","trace[138640471] 'compare' (duration: 75.60943ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T03:54:01.677942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.461327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-10-17T03:54:01.677986Z","caller":"traceutil/trace.go:171","msg":"trace[368092250] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:21572; }","duration":"248.57734ms","start":"2026-10-17T03:54:01.429395Z","end":"2026-10-17T03:54:01.677973Z","steps":["trace[368092250] 'agreement among raft nodes before linearized reading' (duration: 248.395115ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:54:01.677992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.711495ms","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-17T03:54:01.678055Z","caller":"traceutil/trace.go:171","msg":"trace[986334208] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21572; }","duration":"244.815448ms","start":"2026-10-17T03:54:01.433223Z","end":"2026-10-17T03:54:01.678039Z","steps":["trace[986334208] 'agreement among raft nodes before linearized reading' (duration: 244.662434ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:54:01.678048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.117748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:119"} {"level":"info","ts":"2026-10-17T03:54:01.678107Z","caller":"traceutil/trace.go:171","msg":"trace[1085325161] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:21572; }","duration":"123.273822ms","start":"2026-10-17T03:54:01.554818Z","end":"2026-10-17T03:54:01.678092Z","steps":["trace[1085325161] 'agreement among raft nodes before linearized reading' (duration: 123.087617ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:54:01.678117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.215154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12431"} {"level":"info","ts":"2026-10-17T03:54:01.678176Z","caller":"traceutil/trace.go:171","msg":"trace[338447022] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:21572; }","duration":"243.322367ms","start":"2026-10-17T03:54:01.434838Z","end":"2026-10-17T03:54:01.67816Z","steps":["trace[338447022] 'agreement among raft nodes before linearized reading' (duration: 243.088241ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:54:01.943547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.76732ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T03:54:01.943863Z","caller":"traceutil/trace.go:171","msg":"trace[1539201548] linearizableReadLoop","detail":"{readStateIndex:22313; appliedIndex:22311; }","duration":"258.18119ms","start":"2026-10-17T03:54:01.685664Z","end":"2026-10-17T03:54:01.943845Z","steps":["trace[1539201548] 'read index received' (duration: 131.975458ms)","trace[1539201548] 'applied index is now lower than readState.Index' (duration: 126.204622ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T03:54:01.943967Z","caller":"traceutil/trace.go:171","msg":"trace[975767328] transaction","detail":"{read_only:false; response_revision:21573; number_of_response:1; }","duration":"261.551722ms","start":"2026-10-17T03:54:01.682403Z","end":"2026-10-17T03:54:01.943955Z","steps":["trace[975767328] 'process raft request' (duration: 135.295369ms)","trace[975767328] 'compare' (duration: 125.600765ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T03:54:01.944129Z","caller":"traceutil/trace.go:171","msg":"trace[1369866445] transaction","detail":"{read_only:false; response_revision:21575; number_of_response:1; }","duration":"231.414484ms","start":"2026-10-17T03:54:01.712659Z","end":"2026-10-17T03:54:01.944074Z","steps":["trace[1369866445] 'process raft request' (duration: 231.062435ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:54:01.944325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.667174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:119"} {"level":"info","ts":"2026-10-17T03:54:01.944371Z","caller":"traceutil/trace.go:171","msg":"trace[1345541087] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:21575; }","duration":"258.776686ms","start":"2026-10-17T03:54:01.685582Z","end":"2026-10-17T03:54:01.944358Z","steps":["trace[1345541087] 'agreement among raft nodes before linearized reading' (duration: 258.588671ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:54:01.944403Z","caller":"traceutil/trace.go:171","msg":"trace[1527834662] transaction","detail":"{read_only:false; response_revision:21574; number_of_response:1; }","duration":"261.84342ms","start":"2026-10-17T03:54:01.682537Z","end":"2026-10-17T03:54:01.94438Z","steps":["trace[1527834662] 'process raft request' (duration: 261.13242ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T03:54:01.944686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.849047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:123278"} {"level":"warn","ts":"2026-10-17T03:54:01.944632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.011474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T03:54:01.944759Z","caller":"traceutil/trace.go:171","msg":"trace[703599737] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:21575; }","duration":"255.954489ms","start":"2026-10-17T03:54:01.688788Z","end":"2026-10-17T03:54:01.944743Z","steps":["trace[703599737] 'agreement among raft nodes before linearized reading' (duration: 255.696922ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:54:01.944817Z","caller":"traceutil/trace.go:171","msg":"trace[2124082217] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:21575; }","duration":"200.280361ms","start":"2026-10-17T03:54:01.744513Z","end":"2026-10-17T03:54:01.944794Z","steps":["trace[2124082217] 'agreement among raft nodes before linearized reading' (duration: 199.992473ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:54:02.276242Z","caller":"traceutil/trace.go:171","msg":"trace[1009946155] transaction","detail":"{read_only:false; response_revision:21576; number_of_response:1; }","duration":"146.744169ms","start":"2026-10-17T03:54:02.129471Z","end":"2026-10-17T03:54:02.276216Z","steps":["trace[1009946155] 'process raft request' (duration: 128.199326ms)","trace[1009946155] 'compare' (duration: 18.242135ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T03:54:02.507437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.028046ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T03:54:02.507684Z","caller":"traceutil/trace.go:171","msg":"trace[1480496899] transaction","detail":"{read_only:false; response_revision:21577; number_of_response:1; }","duration":"226.551583ms","start":"2026-10-17T03:54:02.281105Z","end":"2026-10-17T03:54:02.507657Z","steps":["trace[1480496899] 'process raft request' (duration: 124.191778ms)","trace[1480496899] 'compare' (duration: 101.79615ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T03:54:02.529138Z","caller":"traceutil/trace.go:171","msg":"trace[1244382113] transaction","detail":"{read_only:false; response_revision:21578; number_of_response:1; }","duration":"247.766048ms","start":"2026-10-17T03:54:02.281343Z","end":"2026-10-17T03:54:02.52911Z","steps":["trace[1244382113] 'process raft request' (duration: 247.615014ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:58:06.614594Z","caller":"traceutil/trace.go:171","msg":"trace[1705913453] transaction","detail":"{read_only:false; response_revision:24103; number_of_response:1; }","duration":"252.118876ms","start":"2026-10-17T03:58:06.362446Z","end":"2026-10-17T03:58:06.614565Z","steps":["trace[1705913453] 'process raft request' (duration: 251.764087ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T03:58:59.962434Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21564} {"level":"info","ts":"2026-10-17T03:59:00.078114Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21564,"took":"110.252609ms","hash":1867325536,"current-db-size-bytes":56299520,"current-db-size":"56 MB","current-db-size-in-use-bytes":42635264,"current-db-size-in-use":"43 MB"} {"level":"info","ts":"2026-10-17T03:59:00.078181Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1867325536,"revision":21564,"compact-revision":19499} {"level":"info","ts":"2026-10-17T04:00:29.426928Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006761.wal"} {"level":"warn","ts":"2026-10-17T04:01:45.294339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.494872ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T04:01:45.294443Z","caller":"traceutil/trace.go:171","msg":"trace[1221614176] linearizableReadLoop","detail":"{readStateIndex:27163; appliedIndex:27161; }","duration":"344.531302ms","start":"2026-10-17T04:01:44.949895Z","end":"2026-10-17T04:01:45.294426Z","steps":["trace[1221614176] 'read index received' (duration: 55.266709ms)","trace[1221614176] 'applied index is now lower than readState.Index' (duration: 289.263203ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T04:01:45.294506Z","caller":"traceutil/trace.go:171","msg":"trace[1900674166] transaction","detail":"{read_only:false; response_revision:26294; number_of_response:1; }","duration":"346.913227ms","start":"2026-10-17T04:01:44.947582Z","end":"2026-10-17T04:01:45.294495Z","steps":["trace[1900674166] 'process raft request' (duration: 193.172388ms)","trace[1900674166] 'compare' (duration: 152.961188ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T04:01:45.294558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T04:01:44.947556Z","time spent":"346.970448ms","remote":"127.0.0.1:40580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T04:01:45.294795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.887052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-17T04:01:45.294889Z","caller":"traceutil/trace.go:171","msg":"trace[1441599962] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26294; }","duration":"345.026866ms","start":"2026-10-17T04:01:44.94984Z","end":"2026-10-17T04:01:45.294867Z","steps":["trace[1441599962] 'agreement among raft nodes before linearized reading' (duration: 344.760719ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T04:01:45.294938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T04:01:44.949817Z","time spent":"345.109147ms","remote":"127.0.0.1:40580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-10-17T04:01:45.306673Z","caller":"traceutil/trace.go:171","msg":"trace[1450272724] transaction","detail":"{read_only:false; response_revision:26295; number_of_response:1; }","duration":"112.344517ms","start":"2026-10-17T04:01:45.19428Z","end":"2026-10-17T04:01:45.306624Z","steps":["trace[1450272724] 'process raft request' (duration: 112.193502ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T04:01:45.436375Z","caller":"traceutil/trace.go:171","msg":"trace[1944894033] linearizableReadLoop","detail":"{readStateIndex:27165; appliedIndex:27163; }","duration":"141.884107ms","start":"2026-10-17T04:01:45.294464Z","end":"2026-10-17T04:01:45.436348Z","steps":["trace[1944894033] 'read index received' (duration: 12.041036ms)","trace[1944894033] 'applied index is now lower than readState.Index' (duration: 129.841861ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T04:01:45.436467Z","caller":"traceutil/trace.go:171","msg":"trace[1076657442] transaction","detail":"{read_only:false; response_revision:26297; number_of_response:1; }","duration":"136.735348ms","start":"2026-10-17T04:01:45.299688Z","end":"2026-10-17T04:01:45.436423Z","steps":["trace[1076657442] 'process raft request' (duration: 136.597344ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T04:01:45.436568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.629738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T04:01:45.436622Z","caller":"traceutil/trace.go:171","msg":"trace[1078612750] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0; response_count:0; response_revision:26297; }","duration":"263.70577ms","start":"2026-10-17T04:01:45.172899Z","end":"2026-10-17T04:01:45.436604Z","steps":["trace[1078612750] 'agreement among raft nodes before linearized reading' (duration: 263.596117ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T04:01:45.436666Z","caller":"traceutil/trace.go:171","msg":"trace[804027871] transaction","detail":"{read_only:false; response_revision:26296; number_of_response:1; }","duration":"225.69731ms","start":"2026-10-17T04:01:45.210938Z","end":"2026-10-17T04:01:45.436635Z","steps":["trace[804027871] 'process raft request' (duration: 213.134549ms)","trace[804027871] 'compare' (duration: 12.059307ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T04:01:45.436765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.9581ms","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-17T04:01:45.43683Z","caller":"traceutil/trace.go:171","msg":"trace[1703042188] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26297; }","duration":"270.054573ms","start":"2026-10-17T04:01:45.166759Z","end":"2026-10-17T04:01:45.436813Z","steps":["trace[1703042188] 'agreement among raft nodes before linearized reading' (duration: 269.856307ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T04:01:45.559064Z","caller":"traceutil/trace.go:171","msg":"trace[510651381] linearizableReadLoop","detail":"{readStateIndex:27168; appliedIndex:27166; }","duration":"117.023304ms","start":"2026-10-17T04:01:45.442019Z","end":"2026-10-17T04:01:45.559042Z","steps":["trace[510651381] 'read index received' (duration: 108.281907ms)","trace[510651381] 'applied index is now lower than readState.Index' (duration: 8.740297ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T04:01:45.559079Z","caller":"traceutil/trace.go:171","msg":"trace[897986391] transaction","detail":"{read_only:false; response_revision:26298; number_of_response:1; }","duration":"146.070611ms","start":"2026-10-17T04:01:45.412966Z","end":"2026-10-17T04:01:45.559036Z","steps":["trace[897986391] 'process raft request' (duration: 137.313263ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T04:01:45.559136Z","caller":"traceutil/trace.go:171","msg":"trace[1848609146] transaction","detail":"{read_only:false; response_revision:26299; number_of_response:1; }","duration":"117.647471ms","start":"2026-10-17T04:01:45.441466Z","end":"2026-10-17T04:01:45.559113Z","steps":["trace[1848609146] 'process raft request' (duration: 117.431635ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T04:01:45.559183Z","caller":"traceutil/trace.go:171","msg":"trace[1712364405] transaction","detail":"{read_only:false; response_revision:26300; number_of_response:1; }","duration":"110.996539ms","start":"2026-10-17T04:01:45.448177Z","end":"2026-10-17T04:01:45.559173Z","steps":["trace[1712364405] 'process raft request' (duration: 110.809834ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T04:01:45.559357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.308561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusterclasses/\" range_end:\"/registry/cluster.x-k8s.io/clusterclasses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T04:01:45.559769Z","caller":"traceutil/trace.go:171","msg":"trace[1645359206] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusterclasses/; range_end:/registry/cluster.x-k8s.io/clusterclasses0; response_count:0; response_revision:26300; }","duration":"117.756093ms","start":"2026-10-17T04:01:45.441991Z","end":"2026-10-17T04:01:45.559747Z","steps":["trace[1645359206] 'agreement among raft nodes before linearized reading' (duration: 117.210918ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T04:02:39.841322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.298157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-17T04:02:39.841446Z","caller":"traceutil/trace.go:171","msg":"trace[823904708] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26803; }","duration":"128.471872ms","start":"2026-10-17T04:02:39.712951Z","end":"2026-10-17T04:02:39.841422Z","steps":["trace[823904708] 'range keys from in-memory index tree' (duration: 128.009568ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T04:02:39.852631Z","caller":"traceutil/trace.go:171","msg":"trace[2128585775] transaction","detail":"{read_only:false; response_revision:26804; number_of_response:1; }","duration":"102.031562ms","start":"2026-10-17T04:02:39.750567Z","end":"2026-10-17T04:02:39.852598Z","steps":["trace[2128585775] 'process raft request' (duration: 101.838887ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T04:02:45.369102Z","caller":"traceutil/trace.go:171","msg":"trace[287388140] transaction","detail":"{read_only:false; response_revision:26845; number_of_response:1; }","duration":"120.772112ms","start":"2026-10-17T04:02:45.248302Z","end":"2026-10-17T04:02:45.369074Z","steps":["trace[287388140] 'process raft request' (duration: 120.615217ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T04:02:45.56403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.885486ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T04:02:45.564356Z","caller":"traceutil/trace.go:171","msg":"trace[507147567] transaction","detail":"{read_only:false; response_revision:26846; number_of_response:1; }","duration":"256.758407ms","start":"2026-10-17T04:02:45.307577Z","end":"2026-10-17T04:02:45.564335Z","steps":["trace[507147567] 'process raft request' (duration: 125.48037ms)","trace[507147567] 'compare' (duration: 130.745293ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T04:02:45.805884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.953987ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T04:02:45.806006Z","caller":"traceutil/trace.go:171","msg":"trace[1308305214] transaction","detail":"{read_only:false; response_revision:26847; number_of_response:1; }","duration":"261.414974ms","start":"2026-10-17T04:02:45.544566Z","end":"2026-10-17T04:02:45.805981Z","steps":["trace[1308305214] 'process raft request' (duration: 147.269752ms)","trace[1308305214] 'compare' (duration: 113.71826ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T04:02:46.258452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.852278ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T04:02:46.258737Z","caller":"traceutil/trace.go:171","msg":"trace[1419398285] transaction","detail":"{read_only:false; response_revision:26850; number_of_response:1; }","duration":"388.454315ms","start":"2026-10-17T04:02:45.870239Z","end":"2026-10-17T04:02:46.258694Z","steps":["trace[1419398285] 'process raft request' (duration: 388.376533ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T04:02:46.258728Z","caller":"traceutil/trace.go:171","msg":"trace[770929715] linearizableReadLoop","detail":"{readStateIndex:27731; appliedIndex:27729; }","duration":"659.068049ms","start":"2026-10-17T04:02:45.599622Z","end":"2026-10-17T04:02:46.25869Z","steps":["trace[770929715] 'read index received' (duration: 92.226516ms)","trace[770929715] 'applied index is now lower than readState.Index' (duration: 566.840103ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T04:02:46.258749Z","caller":"traceutil/trace.go:171","msg":"trace[368623823] transaction","detail":"{read_only:false; response_revision:26848; number_of_response:1; }","duration":"671.564869ms","start":"2026-10-17T04:02:45.587121Z","end":"2026-10-17T04:02:46.258686Z","steps":["trace[368623823] 'process raft request' (duration: 403.390602ms)","trace[368623823] 'compare' (duration: 267.738175ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T04:02:46.2588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T04:02:45.870219Z","time spent":"388.550448ms","remote":"127.0.0.1:40580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T04:02:46.258868Z","caller":"traceutil/trace.go:171","msg":"trace[750384246] transaction","detail":"{read_only:false; response_revision:26851; number_of_response:1; }","duration":"317.937329ms","start":"2026-10-17T04:02:45.940909Z","end":"2026-10-17T04:02:46.258846Z","steps":["trace[750384246] 'process raft request' (duration: 317.748934ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T04:02:46.25895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T04:02:45.587088Z","time spent":"671.723912ms","remote":"127.0.0.1:40580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T04:02:46.258989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.356807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"warn","ts":"2026-10-17T04:02:46.258992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T04:02:45.94089Z","time spent":"318.034162ms","remote":"127.0.0.1:40580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T04:02:46.259025Z","caller":"traceutil/trace.go:171","msg":"trace[2041670894] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26851; }","duration":"659.447019ms","start":"2026-10-17T04:02:45.599568Z","end":"2026-10-17T04:02:46.259015Z","steps":["trace[2041670894] 'agreement among raft nodes before linearized reading' (duration: 659.242193ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T04:02:46.259056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T04:02:45.599552Z","time spent":"659.497091ms","remote":"127.0.0.1:40580","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-17T04:02:46.259057Z","caller":"traceutil/trace.go:171","msg":"trace[643400289] transaction","detail":"{read_only:false; response_revision:26852; number_of_response:1; }","duration":"306.18595ms","start":"2026-10-17T04:02:45.952852Z","end":"2026-10-17T04:02:46.259038Z","steps":["trace[643400289] 'process raft request' (duration: 305.922382ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T04:02:46.259141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T04:02:45.952827Z","time spent":"306.270142ms","remote":"127.0.0.1:40580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T04:02:46.259313Z","caller":"traceutil/trace.go:171","msg":"trace[1491703437] transaction","detail":"{read_only:false; response_revision:26849; number_of_response:1; }","duration":"595.336377ms","start":"2026-10-17T04:02:45.663321Z","end":"2026-10-17T04:02:46.258657Z","steps":["trace[1491703437] 'process raft request' (duration: 595.230144ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T04:02:46.260139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T04:02:45.66329Z","time spent":"596.633033ms","remote":"127.0.0.1:40580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T04:02:46.294592Z","caller":"traceutil/trace.go:171","msg":"trace[411098794] transaction","detail":"{read_only:false; response_revision:26853; number_of_response:1; }","duration":"143.972412ms","start":"2026-10-17T04:02:46.150595Z","end":"2026-10-17T04:02:46.294567Z","steps":["trace[411098794] 'process raft request' (duration: 143.410467ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T04:02:46.294608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.774942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T04:02:46.294679Z","caller":"traceutil/trace.go:171","msg":"trace[1189090008] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddressclaims/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddressclaims0; response_count:0; response_revision:26853; }","duration":"615.894176ms","start":"2026-10-17T04:02:45.678768Z","end":"2026-10-17T04:02:46.294662Z","steps":["trace[1189090008] 'agreement among raft nodes before linearized reading' (duration: 615.767692ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T04:02:46.294747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T04:02:45.678756Z","time spent":"615.979879ms","remote":"127.0.0.1:39922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":0,"response size":28,"request content":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true "} {"level":"warn","ts":"2026-10-17T04:02:46.294654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.79771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-17T04:02:46.294873Z","caller":"traceutil/trace.go:171","msg":"trace[1031215439] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26853; }","duration":"419.019676ms","start":"2026-10-17T04:02:45.875806Z","end":"2026-10-17T04:02:46.294826Z","steps":["trace[1031215439] 'agreement among raft nodes before linearized reading' (duration: 418.689047ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T04:02:46.2949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.07029ms","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-17T04:02:46.29494Z","caller":"traceutil/trace.go:171","msg":"trace[1536924213] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26853; }","duration":"411.116961ms","start":"2026-10-17T04:02:45.883811Z","end":"2026-10-17T04:02:46.294928Z","steps":["trace[1536924213] 'agreement among raft nodes before linearized reading' (duration: 410.533035ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T04:02:46.29495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T04:02:45.875792Z","time spent":"419.144709ms","remote":"127.0.0.1:40580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-17T04:02:46.294979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T04:02:45.883766Z","time spent":"411.205283ms","remote":"127.0.0.1:40580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-10-17T04:02:46.412568Z","caller":"traceutil/trace.go:171","msg":"trace[579452936] linearizableReadLoop","detail":"{readStateIndex:27737; appliedIndex:27736; }","duration":"118.236503ms","start":"2026-10-17T04:02:46.294309Z","end":"2026-10-17T04:02:46.412546Z","steps":["trace[579452936] 'read index received' (duration: 118.063549ms)","trace[579452936] 'applied index is now lower than readState.Index' (duration: 171.924µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T04:02:46.412619Z","caller":"traceutil/trace.go:171","msg":"trace[1905017438] transaction","detail":"{read_only:false; response_revision:26854; number_of_response:1; }","duration":"148.438794ms","start":"2026-10-17T04:02:46.264153Z","end":"2026-10-17T04:02:46.412591Z","steps":["trace[1905017438] 'process raft request' (duration: 148.231608ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T04:02:46.412771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.069799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/flavors/\" range_end:\"/registry/openstack.k-orc.cloud/flavors0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T04:02:46.412912Z","caller":"traceutil/trace.go:171","msg":"trace[531379349] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/flavors/; range_end:/registry/openstack.k-orc.cloud/flavors0; response_count:0; response_revision:26854; }","duration":"125.228763ms","start":"2026-10-17T04:02:46.287574Z","end":"2026-10-17T04:02:46.412803Z","steps":["trace[531379349] 'agreement among raft nodes before linearized reading' (duration: 125.081089ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T04:02:46.413431Z","caller":"traceutil/trace.go:171","msg":"trace[2147435050] transaction","detail":"{read_only:false; response_revision:26856; number_of_response:1; }","duration":"114.041379ms","start":"2026-10-17T04:02:46.299368Z","end":"2026-10-17T04:02:46.41341Z","steps":["trace[2147435050] 'process raft request' (duration: 113.953236ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T04:02:46.413654Z","caller":"traceutil/trace.go:171","msg":"trace[2035730096] transaction","detail":"{read_only:false; response_revision:26855; number_of_response:1; }","duration":"115.20351ms","start":"2026-10-17T04:02:46.29844Z","end":"2026-10-17T04:02:46.413643Z","steps":["trace[2035730096] 'process raft request' (duration: 114.791089ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T04:02:46.413838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.067014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-9194cc91-950b-4500-a731-fd84a734ecc2\" ","response":"range_response_count:1 size:1323"} {"level":"info","ts":"2026-10-17T04:02:46.413911Z","caller":"traceutil/trace.go:171","msg":"trace[93773050] range","detail":"{range_begin:/registry/persistentvolumes/pvc-9194cc91-950b-4500-a731-fd84a734ecc2; range_end:; response_count:1; response_revision:26857; }","duration":"116.190198ms","start":"2026-10-17T04:02:46.297703Z","end":"2026-10-17T04:02:46.413893Z","steps":["trace[93773050] 'agreement among raft nodes before linearized reading' (duration: 115.852629ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T04:02:46.414008Z","caller":"traceutil/trace.go:171","msg":"trace[1634890781] transaction","detail":"{read_only:false; response_revision:26857; number_of_response:1; }","duration":"110.786211ms","start":"2026-10-17T04:02:46.303204Z","end":"2026-10-17T04:02:46.41399Z","steps":["trace[1634890781] 'process raft request' (duration: 110.169544ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T04:03:59.967833Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24641} {"level":"info","ts":"2026-10-17T04:04:00.125153Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24641,"took":"154.130639ms","hash":1821608252,"current-db-size-bytes":56721408,"current-db-size":"57 MB","current-db-size-in-use-bytes":35770368,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-10-17T04:04:00.125246Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1821608252,"revision":24641,"compact-revision":21564} {"level":"info","ts":"2026-10-17T04:06:26.794402Z","caller":"traceutil/trace.go:171","msg":"trace[1758926009] transaction","detail":"{read_only:false; response_revision:29048; number_of_response:1; }","duration":"116.154266ms","start":"2026-10-17T04:06:26.678223Z","end":"2026-10-17T04:06:26.794378Z","steps":["trace[1758926009] 'process raft request' (duration: 115.982682ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T04:06:28.304466Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"db28a37eabf8270","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T04:06:28.313559Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-10-17T04:06:28.313765Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-10-17T04:08:59.97546Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27570} {"level":"info","ts":"2026-10-17T04:09:00.113059Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27570,"took":"131.866033ms","hash":1680030561,"current-db-size-bytes":57143296,"current-db-size":"57 MB","current-db-size-in-use-bytes":36904960,"current-db-size-in-use":"37 MB"} {"level":"info","ts":"2026-10-17T04:09:00.113133Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1680030561,"revision":27570,"compact-revision":24641} {"level":"info","ts":"2026-10-17T04:13:59.986941Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30304} {"level":"info","ts":"2026-10-17T04:14:00.142726Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30304,"took":"151.150359ms","hash":561012037,"current-db-size-bytes":57143296,"current-db-size":"57 MB","current-db-size-in-use-bytes":31158272,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-17T04:14:00.1428Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":561012037,"revision":30304,"compact-revision":27570} {"level":"info","ts":"2026-10-17T04:18:59.99431Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32556} {"level":"info","ts":"2026-10-17T04:19:00.166424Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32556,"took":"164.487769ms","hash":2178414444,"current-db-size-bytes":57143296,"current-db-size":"57 MB","current-db-size-in-use-bytes":30326784,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-17T04:19:00.166505Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2178414444,"revision":32556,"compact-revision":30304} {"level":"info","ts":"2026-10-17T04:24:00.000808Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34789} {"level":"info","ts":"2026-10-17T04:24:00.142796Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34789,"took":"137.90575ms","hash":1752325418,"current-db-size-bytes":57143296,"current-db-size":"57 MB","current-db-size-in-use-bytes":31641600,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-17T04:24:00.142865Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1752325418,"revision":34789,"compact-revision":32556} {"level":"info","ts":"2026-10-17T04:27:42.146042Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"db28a37eabf8270","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T04:27:42.152364Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-10-17T04:27:42.152646Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-10-17T04:29:00.010777Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37086} {"level":"info","ts":"2026-10-17T04:29:00.132173Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37086,"took":"118.043444ms","hash":919297311,"current-db-size-bytes":59273216,"current-db-size":"59 MB","current-db-size-in-use-bytes":32866304,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-17T04:29:00.132263Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":919297311,"revision":37086,"compact-revision":34789} {"level":"info","ts":"2026-10-17T04:34:00.022214Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39359} {"level":"info","ts":"2026-10-17T04:34:00.162459Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39359,"took":"136.021431ms","hash":3693766404,"current-db-size-bytes":59273216,"current-db-size":"59 MB","current-db-size-in-use-bytes":31318016,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-17T04:34:00.16254Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3693766404,"revision":39359,"compact-revision":37086}