{"level":"warn","ts":"2026-08-04T15:16:57.16477Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-04T15:16:57.165058Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.108:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.108:2380","--initial-cluster=instance=https://199.19.213.108:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.108:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.108: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-08-04T15:16:57.165222Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-04T15:16:57.16525Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.108:2380"]} {"level":"info","ts":"2026-08-04T15:16:57.165295Z","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-08-04T15:16:57.166907Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.108:2379"]} {"level":"info","ts":"2026-08-04T15:16:57.167099Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.108:2380"],"listen-peer-urls":["https://199.19.213.108:2380"],"advertise-client-urls":["https://199.19.213.108:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.108:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.108: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-08-04T15:16:57.170509Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.852217ms"} {"level":"info","ts":"2026-08-04T15:16:57.178247Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e9047e95cdba2056","cluster-id":"51f5e218724a48a2"} {"level":"info","ts":"2026-08-04T15:16:57.178367Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 switched to configuration voters=()"} {"level":"info","ts":"2026-08-04T15:16:57.178405Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 became follower at term 0"} {"level":"info","ts":"2026-08-04T15:16:57.178418Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e9047e95cdba2056 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-04T15:16:57.178437Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 became follower at term 1"} {"level":"info","ts":"2026-08-04T15:16:57.178489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 switched to configuration voters=(16790684492610805846)"} {"level":"warn","ts":"2026-08-04T15:16:57.184889Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-04T15:16:57.186365Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-04T15:16:57.187784Z","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-08-04T15:16:57.190418Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e9047e95cdba2056","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-04T15:16:57.190575Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e9047e95cdba2056","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-04T15:16:57.190856Z","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-08-04T15:16:57.194Z","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-08-04T15:16:57.194038Z","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-08-04T15:16:57.195113Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 switched to configuration voters=(16790684492610805846)"} {"level":"info","ts":"2026-08-04T15:16:57.195421Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"51f5e218724a48a2","local-member-id":"e9047e95cdba2056","added-peer-id":"e9047e95cdba2056","added-peer-peer-urls":["https://199.19.213.108:2380"]} {"level":"info","ts":"2026-08-04T15:16:57.198998Z","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-08-04T15:16:57.199112Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.108:2380"} {"level":"info","ts":"2026-08-04T15:16:57.199161Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.108:2380"} {"level":"info","ts":"2026-08-04T15:16:57.19937Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e9047e95cdba2056","initial-advertise-peer-urls":["https://199.19.213.108:2380"],"listen-peer-urls":["https://199.19.213.108:2380"],"advertise-client-urls":["https://199.19.213.108:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.108:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-04T15:16:57.199426Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-04T15:16:57.890777Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 is starting a new election at term 1"} {"level":"info","ts":"2026-08-04T15:16:57.89088Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-04T15:16:57.890924Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 received MsgPreVoteResp from e9047e95cdba2056 at term 1"} {"level":"info","ts":"2026-08-04T15:16:57.890949Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 became candidate at term 2"} {"level":"info","ts":"2026-08-04T15:16:57.890959Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 received MsgVoteResp from e9047e95cdba2056 at term 2"} {"level":"info","ts":"2026-08-04T15:16:57.890977Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e9047e95cdba2056 became leader at term 2"} {"level":"info","ts":"2026-08-04T15:16:57.890999Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e9047e95cdba2056 elected leader e9047e95cdba2056 at term 2"} {"level":"info","ts":"2026-08-04T15:16:57.913658Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T15:16:57.915349Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e9047e95cdba2056","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.108:2379]}","request-path":"/0/members/e9047e95cdba2056/attributes","cluster-id":"51f5e218724a48a2","publish-timeout":"7s"} {"level":"info","ts":"2026-08-04T15:16:57.915357Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-04T15:16:57.915423Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-04T15:16:57.915869Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"51f5e218724a48a2","local-member-id":"e9047e95cdba2056","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T15:16:57.91585Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-04T15:16:57.915959Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-04T15:16:57.91602Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T15:16:57.916077Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T15:16:57.918098Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.108:2379"} {"level":"info","ts":"2026-08-04T15:16:57.918619Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-04T15:17:10.70501Z","caller":"traceutil/trace.go:171","msg":"trace[1572524201] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"152.045121ms","start":"2026-08-04T15:17:10.55293Z","end":"2026-08-04T15:17:10.704975Z","steps":["trace[1572524201] 'process raft request' (duration: 151.845586ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:17:10.913084Z","caller":"traceutil/trace.go:171","msg":"trace[228533502] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"203.689287ms","start":"2026-08-04T15:17:10.709365Z","end":"2026-08-04T15:17:10.913054Z","steps":["trace[228533502] 'process raft request' (duration: 203.552724ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:17:21.330328Z","caller":"traceutil/trace.go:171","msg":"trace[1059084117] linearizableReadLoop","detail":"{readStateIndex:444; appliedIndex:443; }","duration":"279.110649ms","start":"2026-08-04T15:17:21.051193Z","end":"2026-08-04T15:17:21.330304Z","steps":["trace[1059084117] 'read index received' (duration: 278.807742ms)","trace[1059084117] 'applied index is now lower than readState.Index' (duration: 301.687µs)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:17:21.330486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.268463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.108\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-04T15:17:21.330574Z","caller":"traceutil/trace.go:171","msg":"trace[955048118] range","detail":"{range_begin:/registry/masterleases/199.19.213.108; range_end:; response_count:1; response_revision:432; }","duration":"279.373095ms","start":"2026-08-04T15:17:21.051187Z","end":"2026-08-04T15:17:21.330561Z","steps":["trace[955048118] 'agreement among raft nodes before linearized reading' (duration: 279.216751ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:17:21.330515Z","caller":"traceutil/trace.go:171","msg":"trace[95473269] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"337.83894ms","start":"2026-08-04T15:17:20.992618Z","end":"2026-08-04T15:17:21.330457Z","steps":["trace[95473269] 'process raft request' (duration: 337.534273ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:17:21.331344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:17:20.992594Z","time spent":"338.055126ms","remote":"127.0.0.1:48598","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4180,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:17:40.63365Z","caller":"traceutil/trace.go:171","msg":"trace[1430367586] transaction","detail":"{read_only:false; number_of_response:1; response_revision:588; }","duration":"252.547288ms","start":"2026-08-04T15:17:40.381063Z","end":"2026-08-04T15:17:40.633611Z","steps":["trace[1430367586] 'process raft request' (duration: 248.298348ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:17:40.633849Z","caller":"traceutil/trace.go:171","msg":"trace[1324512699] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"201.822843ms","start":"2026-08-04T15:17:40.431999Z","end":"2026-08-04T15:17:40.633822Z","steps":["trace[1324512699] 'process raft request' (duration: 201.569297ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:17:47.237571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.598174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-04T15:17:47.237741Z","caller":"traceutil/trace.go:171","msg":"trace[1904975568] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:647; }","duration":"308.83684ms","start":"2026-08-04T15:17:46.928878Z","end":"2026-08-04T15:17:47.237715Z","steps":["trace[1904975568] 'range keys from in-memory index tree' (duration: 308.366249ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:17:47.237813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:17:46.928861Z","time spent":"308.936022ms","remote":"127.0.0.1:48430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-04T15:17:47.266893Z","caller":"traceutil/trace.go:171","msg":"trace[42530236] linearizableReadLoop","detail":"{readStateIndex:670; appliedIndex:669; }","duration":"166.912171ms","start":"2026-08-04T15:17:47.099952Z","end":"2026-08-04T15:17:47.266864Z","steps":["trace[42530236] 'read index received' (duration: 166.04914ms)","trace[42530236] 'applied index is now lower than readState.Index' (duration: 861.831µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:17:47.266964Z","caller":"traceutil/trace.go:171","msg":"trace[675116853] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"172.232577ms","start":"2026-08-04T15:17:47.094699Z","end":"2026-08-04T15:17:47.266931Z","steps":["trace[675116853] 'process raft request' (duration: 171.54439ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:17:47.267159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.176908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-04T15:17:47.267211Z","caller":"traceutil/trace.go:171","msg":"trace[2124107182] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:648; }","duration":"167.268669ms","start":"2026-08-04T15:17:47.099929Z","end":"2026-08-04T15:17:47.267197Z","steps":["trace[2124107182] 'agreement among raft nodes before linearized reading' (duration: 167.078735ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:17:47.296539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.452268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-kxf5w\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-08-04T15:17:47.296664Z","caller":"traceutil/trace.go:171","msg":"trace[1443249126] range","detail":"{range_begin:/registry/pods/kube-system/cilium-kxf5w; range_end:; response_count:1; response_revision:649; }","duration":"100.626851ms","start":"2026-08-04T15:17:47.196012Z","end":"2026-08-04T15:17:47.296638Z","steps":["trace[1443249126] 'agreement among raft nodes before linearized reading' (duration: 100.273043ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:17:47.928615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.737624ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:17:47.928814Z","caller":"traceutil/trace.go:171","msg":"trace[852703946] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"527.504505ms","start":"2026-08-04T15:17:47.401269Z","end":"2026-08-04T15:17:47.928773Z","steps":["trace[852703946] 'process raft request' (duration: 191.908492ms)","trace[852703946] 'compare' (duration: 334.342793ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:17:47.928814Z","caller":"traceutil/trace.go:171","msg":"trace[1648502823] linearizableReadLoop","detail":"{readStateIndex:675; appliedIndex:674; }","duration":"347.087416ms","start":"2026-08-04T15:17:47.581678Z","end":"2026-08-04T15:17:47.928765Z","steps":["trace[1648502823] 'read index received' (duration: 11.489702ms)","trace[1648502823] 'applied index is now lower than readState.Index' (duration: 335.595594ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:17:47.928876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:17:47.401245Z","time spent":"527.605538ms","remote":"127.0.0.1:48368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-04T15:17:47.929167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.494255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-08-04T15:17:47.929197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.070779ms","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-08-04T15:17:47.929229Z","caller":"traceutil/trace.go:171","msg":"trace[629122169] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:653; }","duration":"171.142481ms","start":"2026-08-04T15:17:47.758078Z","end":"2026-08-04T15:17:47.92922Z","steps":["trace[629122169] 'agreement among raft nodes before linearized reading' (duration: 171.045198ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:17:47.929226Z","caller":"traceutil/trace.go:171","msg":"trace[1662359640] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:653; }","duration":"347.611707ms","start":"2026-08-04T15:17:47.581599Z","end":"2026-08-04T15:17:47.92921Z","steps":["trace[1662359640] 'agreement among raft nodes before linearized reading' (duration: 347.373252ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:17:47.929277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:17:47.581572Z","time spent":"347.69509ms","remote":"127.0.0.1:48430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-04T15:17:48.625687Z","caller":"traceutil/trace.go:171","msg":"trace[1492648578] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"692.06528ms","start":"2026-08-04T15:17:47.933591Z","end":"2026-08-04T15:17:48.625656Z","steps":["trace[1492648578] 'process raft request' (duration: 691.807314ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:17:48.625897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:17:47.933571Z","time spent":"692.212064ms","remote":"127.0.0.1:48368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:17:48.626093Z","caller":"traceutil/trace.go:171","msg":"trace[257282230] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"692.46912ms","start":"2026-08-04T15:17:47.933592Z","end":"2026-08-04T15:17:48.626061Z","steps":["trace[257282230] 'process raft request' (duration: 692.002559ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:17:48.626241Z","caller":"traceutil/trace.go:171","msg":"trace[2088606446] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"692.301496ms","start":"2026-08-04T15:17:47.933916Z","end":"2026-08-04T15:17:48.626218Z","steps":["trace[2088606446] 'process raft request' (duration: 691.974789ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:17:48.626285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:17:47.933574Z","time spent":"692.601213ms","remote":"127.0.0.1:48430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:17:48.626328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:17:47.933906Z","time spent":"692.383218ms","remote":"127.0.0.1:48246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-04T15:17:48.626306Z","caller":"traceutil/trace.go:171","msg":"trace[910951775] linearizableReadLoop","detail":"{readStateIndex:681; appliedIndex:676; }","duration":"410.594819ms","start":"2026-08-04T15:17:48.215678Z","end":"2026-08-04T15:17:48.626272Z","steps":["trace[910951775] 'read index received' (duration: 409.613645ms)","trace[910951775] 'applied index is now lower than readState.Index' (duration: 979.634µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:17:48.626321Z","caller":"traceutil/trace.go:171","msg":"trace[120167913] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"692.194614ms","start":"2026-08-04T15:17:47.934094Z","end":"2026-08-04T15:17:48.626288Z","steps":["trace[120167913] 'process raft request' (duration: 691.969529ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:17:48.626502Z","caller":"traceutil/trace.go:171","msg":"trace[1615216140] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"691.729403ms","start":"2026-08-04T15:17:47.93473Z","end":"2026-08-04T15:17:48.62646Z","steps":["trace[1615216140] 'process raft request' (duration: 691.440966ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:17:48.62653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:17:47.934084Z","time spent":"692.334037ms","remote":"127.0.0.1:48430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:17:48.626563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.883686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:17:48.626619Z","caller":"traceutil/trace.go:171","msg":"trace[1839383506] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:659; }","duration":"411.011268ms","start":"2026-08-04T15:17:48.215596Z","end":"2026-08-04T15:17:48.626608Z","steps":["trace[1839383506] 'agreement among raft nodes before linearized reading' (duration: 410.911906ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:17:48.626644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:17:47.934721Z","time spent":"691.844835ms","remote":"127.0.0.1:48412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:17:48.626663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:17:48.215564Z","time spent":"411.092371ms","remote":"127.0.0.1:47940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-04T15:18:04.740489Z","caller":"traceutil/trace.go:171","msg":"trace[362861028] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"243.550035ms","start":"2026-08-04T15:18:04.496902Z","end":"2026-08-04T15:18:04.740452Z","steps":["trace[362861028] 'process raft request' (duration: 149.168521ms)","trace[362861028] 'compare' (duration: 94.2323ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:18:04.788082Z","caller":"traceutil/trace.go:171","msg":"trace[58074517] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"111.907508ms","start":"2026-08-04T15:18:04.676144Z","end":"2026-08-04T15:18:04.788051Z","steps":["trace[58074517] 'process raft request' (duration: 111.247513ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:18:32.705416Z","caller":"traceutil/trace.go:171","msg":"trace[1589679061] transaction","detail":"{read_only:false; response_revision:1210; number_of_response:1; }","duration":"129.409944ms","start":"2026-08-04T15:18:32.575976Z","end":"2026-08-04T15:18:32.705386Z","steps":["trace[1589679061] 'process raft request' (duration: 129.24272ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:19:21.390601Z","caller":"traceutil/trace.go:171","msg":"trace[1056103929] transaction","detail":"{read_only:false; response_revision:1887; number_of_response:1; }","duration":"661.257747ms","start":"2026-08-04T15:19:20.729307Z","end":"2026-08-04T15:19:21.390565Z","steps":["trace[1056103929] 'process raft request' (duration: 660.848597ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:19:21.390829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:19:20.729269Z","time spent":"661.448892ms","remote":"127.0.0.1:48368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3729,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:19:21.403305Z","caller":"traceutil/trace.go:171","msg":"trace[513725802] linearizableReadLoop","detail":"{readStateIndex:1958; appliedIndex:1956; }","duration":"347.928492ms","start":"2026-08-04T15:19:21.055348Z","end":"2026-08-04T15:19:21.403276Z","steps":["trace[513725802] 'read index received' (duration: 334.945416ms)","trace[513725802] 'applied index is now lower than readState.Index' (duration: 12.981766ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:19:21.403514Z","caller":"traceutil/trace.go:171","msg":"trace[1658165583] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"440.046943ms","start":"2026-08-04T15:19:20.963458Z","end":"2026-08-04T15:19:21.403505Z","steps":["trace[1658165583] 'process raft request' (duration: 439.441498ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:19:21.403676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:19:20.963431Z","time spent":"440.133474ms","remote":"127.0.0.1:48430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:19:21.403833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.407654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:19:21.404136Z","caller":"traceutil/trace.go:171","msg":"trace[1133132046] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:1888; }","duration":"348.823434ms","start":"2026-08-04T15:19:21.055285Z","end":"2026-08-04T15:19:21.404108Z","steps":["trace[1133132046] 'agreement among raft nodes before linearized reading' (duration: 348.376543ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:19:21.404196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:19:21.055258Z","time spent":"348.923826ms","remote":"127.0.0.1:45006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-08-04T15:19:21.407005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.440946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.108\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-04T15:19:21.40709Z","caller":"traceutil/trace.go:171","msg":"trace[379168265] range","detail":"{range_begin:/registry/masterleases/199.19.213.108; range_end:; response_count:1; response_revision:1889; }","duration":"351.58386ms","start":"2026-08-04T15:19:21.055488Z","end":"2026-08-04T15:19:21.407071Z","steps":["trace[379168265] 'agreement among raft nodes before linearized reading' (duration: 351.361993ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:19:21.407314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.803994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-04T15:19:21.407356Z","caller":"traceutil/trace.go:171","msg":"trace[235240549] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1889; }","duration":"187.865945ms","start":"2026-08-04T15:19:21.21948Z","end":"2026-08-04T15:19:21.407346Z","steps":["trace[235240549] 'agreement among raft nodes before linearized reading' (duration: 187.745252ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:19:21.40742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.263299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-04T15:19:21.407502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.169325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-04T15:19:21.407515Z","caller":"traceutil/trace.go:171","msg":"trace[155145738] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1889; }","duration":"192.409053ms","start":"2026-08-04T15:19:21.215086Z","end":"2026-08-04T15:19:21.407495Z","steps":["trace[155145738] 'agreement among raft nodes before linearized reading' (duration: 192.26815ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:19:21.407562Z","caller":"traceutil/trace.go:171","msg":"trace[1969953448] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1889; }","duration":"287.259458ms","start":"2026-08-04T15:19:21.120282Z","end":"2026-08-04T15:19:21.407542Z","steps":["trace[1969953448] 'agreement among raft nodes before linearized reading' (duration: 287.115814ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:19:21.407665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.02239ms","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-08-04T15:19:21.407824Z","caller":"traceutil/trace.go:171","msg":"trace[652323692] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1889; }","duration":"191.223505ms","start":"2026-08-04T15:19:21.216586Z","end":"2026-08-04T15:19:21.40781Z","steps":["trace[652323692] 'agreement among raft nodes before linearized reading' (duration: 190.830206ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:19:21.407835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:19:21.055456Z","time spent":"352.358088ms","remote":"127.0.0.1:48186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.108\" "} {"level":"info","ts":"2026-08-04T15:19:35.755663Z","caller":"traceutil/trace.go:171","msg":"trace[1888079783] transaction","detail":"{read_only:false; response_revision:2016; number_of_response:1; }","duration":"301.852883ms","start":"2026-08-04T15:19:35.453778Z","end":"2026-08-04T15:19:35.755631Z","steps":["trace[1888079783] 'process raft request' (duration: 301.649047ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:19:35.755876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:19:35.453758Z","time spent":"302.002137ms","remote":"127.0.0.1:48430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:19:35.76317Z","caller":"traceutil/trace.go:171","msg":"trace[1132359743] transaction","detail":"{read_only:false; response_revision:2017; number_of_response:1; }","duration":"308.207473ms","start":"2026-08-04T15:19:35.454932Z","end":"2026-08-04T15:19:35.763139Z","steps":["trace[1132359743] 'process raft request' (duration: 307.971987ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:19:35.763362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:19:35.454924Z","time spent":"308.338716ms","remote":"127.0.0.1:48430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:19:35.763433Z","caller":"traceutil/trace.go:171","msg":"trace[491337201] transaction","detail":"{read_only:false; response_revision:2018; number_of_response:1; }","duration":"156.462002ms","start":"2026-08-04T15:19:35.606956Z","end":"2026-08-04T15:19:35.763418Z","steps":["trace[491337201] 'process raft request' (duration: 156.129964ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:19:35.763552Z","caller":"traceutil/trace.go:171","msg":"trace[2765505] linearizableReadLoop","detail":"{readStateIndex:2091; appliedIndex:2089; }","duration":"276.535232ms","start":"2026-08-04T15:19:35.486982Z","end":"2026-08-04T15:19:35.763517Z","steps":["trace[2765505] 'read index received' (duration: 268.42ms)","trace[2765505] 'applied index is now lower than readState.Index' (duration: 8.113582ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:19:35.763698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.724307ms","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-08-04T15:19:35.763741Z","caller":"traceutil/trace.go:171","msg":"trace[340887893] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2019; }","duration":"276.819539ms","start":"2026-08-04T15:19:35.486912Z","end":"2026-08-04T15:19:35.763732Z","steps":["trace[340887893] 'agreement among raft nodes before linearized reading' (duration: 276.683956ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:19:35.763957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.948261ms","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-08-04T15:19:35.764042Z","caller":"traceutil/trace.go:171","msg":"trace[1429926066] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2019; }","duration":"271.108075ms","start":"2026-08-04T15:19:35.492913Z","end":"2026-08-04T15:19:35.764021Z","steps":["trace[1429926066] 'agreement among raft nodes before linearized reading' (duration: 270.843848ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:19:35.764021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.043883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-04T15:19:35.764131Z","caller":"traceutil/trace.go:171","msg":"trace[1047199238] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2019; }","duration":"249.191796ms","start":"2026-08-04T15:19:35.514914Z","end":"2026-08-04T15:19:35.764106Z","steps":["trace[1047199238] 'agreement among raft nodes before linearized reading' (duration: 248.837637ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:20:05.095015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.340252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-04T15:20:05.095299Z","caller":"traceutil/trace.go:171","msg":"trace[955634528] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2185; }","duration":"103.604148ms","start":"2026-08-04T15:20:04.991571Z","end":"2026-08-04T15:20:05.095175Z","steps":["trace[955634528] 'range keys from in-memory index tree' (duration: 103.149778ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:20:10.706826Z","caller":"traceutil/trace.go:171","msg":"trace[1374566972] transaction","detail":"{read_only:false; response_revision:2217; number_of_response:1; }","duration":"128.848592ms","start":"2026-08-04T15:20:10.577956Z","end":"2026-08-04T15:20:10.706804Z","steps":["trace[1374566972] 'process raft request' (duration: 128.694049ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:20:11.437286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.188545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:20:11.437385Z","caller":"traceutil/trace.go:171","msg":"trace[2141948844] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2219; }","duration":"221.299217ms","start":"2026-08-04T15:20:11.216065Z","end":"2026-08-04T15:20:11.437365Z","steps":["trace[2141948844] 'range keys from in-memory index tree' (duration: 221.045881ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:20:11.437421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.63522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-04T15:20:11.437526Z","caller":"traceutil/trace.go:171","msg":"trace[1063982808] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2219; }","duration":"293.783803ms","start":"2026-08-04T15:20:11.143715Z","end":"2026-08-04T15:20:11.437499Z","steps":["trace[1063982808] 'range keys from in-memory index tree' (duration: 293.420575ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:20:12.043706Z","caller":"traceutil/trace.go:171","msg":"trace[1933880818] transaction","detail":"{read_only:false; response_revision:2220; number_of_response:1; }","duration":"146.057357ms","start":"2026-08-04T15:20:11.897615Z","end":"2026-08-04T15:20:12.043673Z","steps":["trace[1933880818] 'process raft request' (duration: 145.870173ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:20:12.266802Z","caller":"traceutil/trace.go:171","msg":"trace[1970847701] linearizableReadLoop","detail":"{readStateIndex:2305; appliedIndex:2302; }","duration":"318.428383ms","start":"2026-08-04T15:20:11.948348Z","end":"2026-08-04T15:20:12.266776Z","steps":["trace[1970847701] 'read index received' (duration: 95.131568ms)","trace[1970847701] 'applied index is now lower than readState.Index' (duration: 223.295755ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:20:12.266854Z","caller":"traceutil/trace.go:171","msg":"trace[1527737927] transaction","detail":"{read_only:false; response_revision:2221; number_of_response:1; }","duration":"368.388739ms","start":"2026-08-04T15:20:11.898433Z","end":"2026-08-04T15:20:12.266822Z","steps":["trace[1527737927] 'process raft request' (duration: 368.142433ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:20:12.26689Z","caller":"traceutil/trace.go:171","msg":"trace[660312427] transaction","detail":"{read_only:false; response_revision:2222; number_of_response:1; }","duration":"356.543669ms","start":"2026-08-04T15:20:11.910323Z","end":"2026-08-04T15:20:12.266867Z","steps":["trace[660312427] 'process raft request' (duration: 356.410226ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:20:12.266998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:20:11.910296Z","time spent":"356.633252ms","remote":"127.0.0.1:48430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:20:12.266998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:20:11.898415Z","time spent":"368.513952ms","remote":"127.0.0.1:48430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:20:12.26707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.707909ms","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-08-04T15:20:12.26711Z","caller":"traceutil/trace.go:171","msg":"trace[1946239260] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2222; }","duration":"318.800442ms","start":"2026-08-04T15:20:11.948297Z","end":"2026-08-04T15:20:12.267097Z","steps":["trace[1946239260] 'agreement among raft nodes before linearized reading' (duration: 318.614207ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:20:12.267145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:20:11.948273Z","time spent":"318.863664ms","remote":"127.0.0.1:48430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-04T15:20:12.267479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.661084ms","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-08-04T15:20:12.267529Z","caller":"traceutil/trace.go:171","msg":"trace[2062612381] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2223; }","duration":"317.753946ms","start":"2026-08-04T15:20:11.949762Z","end":"2026-08-04T15:20:12.267516Z","steps":["trace[2062612381] 'agreement among raft nodes before linearized reading' (duration: 317.597793ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:20:12.267564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:20:11.949726Z","time spent":"317.828158ms","remote":"127.0.0.1:48430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-04T15:20:12.267698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.313464ms","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-08-04T15:20:12.267696Z","caller":"traceutil/trace.go:171","msg":"trace[1519957827] transaction","detail":"{read_only:false; response_revision:2223; number_of_response:1; }","duration":"203.14889ms","start":"2026-08-04T15:20:12.064518Z","end":"2026-08-04T15:20:12.267667Z","steps":["trace[1519957827] 'process raft request' (duration: 202.73597ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:20:12.267754Z","caller":"traceutil/trace.go:171","msg":"trace[1262240524] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2223; }","duration":"138.389796ms","start":"2026-08-04T15:20:12.129333Z","end":"2026-08-04T15:20:12.267723Z","steps":["trace[1262240524] 'agreement among raft nodes before linearized reading' (duration: 138.302574ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:20:17.565315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.544043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:20:17.56547Z","caller":"traceutil/trace.go:171","msg":"trace[1439053498] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:2250; }","duration":"272.759498ms","start":"2026-08-04T15:20:17.292662Z","end":"2026-08-04T15:20:17.565422Z","steps":["trace[1439053498] 'count revisions from in-memory index tree' (duration: 272.460651ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:37.512776Z","caller":"traceutil/trace.go:171","msg":"trace[2030168604] linearizableReadLoop","detail":"{readStateIndex:2985; appliedIndex:2984; }","duration":"140.459153ms","start":"2026-08-04T15:21:37.372292Z","end":"2026-08-04T15:21:37.512751Z","steps":["trace[2030168604] 'read index received' (duration: 139.191802ms)","trace[2030168604] 'applied index is now lower than readState.Index' (duration: 1.266181ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:21:37.513071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.760691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-04T15:21:37.513212Z","caller":"traceutil/trace.go:171","msg":"trace[1889142705] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:2877; }","duration":"140.979736ms","start":"2026-08-04T15:21:37.372197Z","end":"2026-08-04T15:21:37.513177Z","steps":["trace[1889142705] 'agreement among raft nodes before linearized reading' (duration: 140.72532ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:21:37.513568Z","caller":"traceutil/trace.go:171","msg":"trace[205591842] transaction","detail":"{read_only:false; response_revision:2877; number_of_response:1; }","duration":"178.245364ms","start":"2026-08-04T15:21:37.334595Z","end":"2026-08-04T15:21:37.51284Z","steps":["trace[205591842] 'process raft request' (duration: 177.919046ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:23:42.418631Z","caller":"traceutil/trace.go:171","msg":"trace[1585912918] transaction","detail":"{read_only:false; response_revision:3703; number_of_response:1; }","duration":"124.533545ms","start":"2026-08-04T15:23:42.294041Z","end":"2026-08-04T15:23:42.418575Z","steps":["trace[1585912918] 'process raft request' (duration: 70.980284ms)","trace[1585912918] 'compare' (duration: 53.285925ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:24:12.881895Z","caller":"traceutil/trace.go:171","msg":"trace[1880296307] transaction","detail":"{read_only:false; response_revision:3896; number_of_response:1; }","duration":"112.080061ms","start":"2026-08-04T15:24:12.769787Z","end":"2026-08-04T15:24:12.881867Z","steps":["trace[1880296307] 'process raft request' (duration: 111.917837ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:25:40.531526Z","caller":"traceutil/trace.go:171","msg":"trace[814919469] transaction","detail":"{read_only:false; response_revision:4903; number_of_response:1; }","duration":"203.165258ms","start":"2026-08-04T15:25:40.32833Z","end":"2026-08-04T15:25:40.531495Z","steps":["trace[814919469] 'process raft request' (duration: 166.316171ms)","trace[814919469] 'compare' (duration: 36.428597ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:25:40.573746Z","caller":"traceutil/trace.go:171","msg":"trace[15481582] linearizableReadLoop","detail":"{readStateIndex:5090; appliedIndex:5088; }","duration":"191.221817ms","start":"2026-08-04T15:25:40.382492Z","end":"2026-08-04T15:25:40.573714Z","steps":["trace[15481582] 'read index received' (duration: 112.274491ms)","trace[15481582] 'applied index is now lower than readState.Index' (duration: 78.945976ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:25:40.573836Z","caller":"traceutil/trace.go:171","msg":"trace[656999737] transaction","detail":"{read_only:false; response_revision:4904; number_of_response:1; }","duration":"215.621221ms","start":"2026-08-04T15:25:40.358164Z","end":"2026-08-04T15:25:40.573785Z","steps":["trace[656999737] 'process raft request' (duration: 215.395256ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:25:40.574184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.671918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-791babd5-120a-409f-811d-0820a8e19205\" ","response":"range_response_count:1 size:3774"} {"level":"info","ts":"2026-08-04T15:25:40.574279Z","caller":"traceutil/trace.go:171","msg":"trace[1860167148] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-791babd5-120a-409f-811d-0820a8e19205; range_end:; response_count:1; response_revision:4904; }","duration":"191.880633ms","start":"2026-08-04T15:25:40.382376Z","end":"2026-08-04T15:25:40.574256Z","steps":["trace[1860167148] 'agreement among raft nodes before linearized reading' (duration: 191.516674ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:25:41.092389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.187883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"} {"level":"info","ts":"2026-08-04T15:25:41.092461Z","caller":"traceutil/trace.go:171","msg":"trace[1676706317] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:4908; }","duration":"153.318246ms","start":"2026-08-04T15:25:40.939127Z","end":"2026-08-04T15:25:41.092445Z","steps":["trace[1676706317] 'range keys from in-memory index tree' (duration: 153.002098ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:25:41.092456Z","caller":"traceutil/trace.go:171","msg":"trace[2008543463] transaction","detail":"{read_only:false; response_revision:4909; number_of_response:1; }","duration":"101.902967ms","start":"2026-08-04T15:25:40.99053Z","end":"2026-08-04T15:25:41.092433Z","steps":["trace[2008543463] 'process raft request' (duration: 97.873662ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:25:41.369209Z","caller":"traceutil/trace.go:171","msg":"trace[463039345] linearizableReadLoop","detail":"{readStateIndex:5098; appliedIndex:5097; }","duration":"153.184743ms","start":"2026-08-04T15:25:41.216004Z","end":"2026-08-04T15:25:41.369189Z","steps":["trace[463039345] 'read index received' (duration: 153.07288ms)","trace[463039345] 'applied index is now lower than readState.Index' (duration: 111.183µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:25:41.369307Z","caller":"traceutil/trace.go:171","msg":"trace[2143638843] transaction","detail":"{read_only:false; response_revision:4911; number_of_response:1; }","duration":"205.037221ms","start":"2026-08-04T15:25:41.164249Z","end":"2026-08-04T15:25:41.369287Z","steps":["trace[2143638843] 'process raft request' (duration: 204.789066ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:25:41.369469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.423838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:25:41.369592Z","caller":"traceutil/trace.go:171","msg":"trace[1756293829] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4911; }","duration":"153.623293ms","start":"2026-08-04T15:25:41.215946Z","end":"2026-08-04T15:25:41.369569Z","steps":["trace[1756293829] 'agreement among raft nodes before linearized reading' (duration: 153.373527ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:25:41.375084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.598573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-04T15:25:41.375142Z","caller":"traceutil/trace.go:171","msg":"trace[1747382347] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:4912; }","duration":"122.718355ms","start":"2026-08-04T15:25:41.25241Z","end":"2026-08-04T15:25:41.375128Z","steps":["trace[1747382347] 'agreement among raft nodes before linearized reading' (duration: 122.553542ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:25:41.696272Z","caller":"traceutil/trace.go:171","msg":"trace[813760218] transaction","detail":"{read_only:false; response_revision:4917; number_of_response:1; }","duration":"110.60056ms","start":"2026-08-04T15:25:41.585627Z","end":"2026-08-04T15:25:41.696227Z","steps":["trace[813760218] 'process raft request' (duration: 110.322824ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:25:41.992715Z","caller":"traceutil/trace.go:171","msg":"trace[1784591891] transaction","detail":"{read_only:false; response_revision:4919; number_of_response:1; }","duration":"159.840739ms","start":"2026-08-04T15:25:41.832842Z","end":"2026-08-04T15:25:41.992683Z","steps":["trace[1784591891] 'process raft request' (duration: 159.636064ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:25:43.356882Z","caller":"traceutil/trace.go:171","msg":"trace[956126018] transaction","detail":"{read_only:false; response_revision:4966; number_of_response:1; }","duration":"154.317009ms","start":"2026-08-04T15:25:43.202529Z","end":"2026-08-04T15:25:43.356846Z","steps":["trace[956126018] 'process raft request' (duration: 98.197469ms)","trace[956126018] 'compare' (duration: 55.888775ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:25:43.357714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.726959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:50 size:2210296"} {"level":"info","ts":"2026-08-04T15:25:43.357836Z","caller":"traceutil/trace.go:171","msg":"trace[1415147766] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:50; response_revision:4965; }","duration":"160.910954ms","start":"2026-08-04T15:25:43.196902Z","end":"2026-08-04T15:25:43.357813Z","steps":["trace[1415147766] 'range keys from in-memory index tree' (duration: 159.625714ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:25:43.390109Z","caller":"traceutil/trace.go:171","msg":"trace[992015405] linearizableReadLoop","detail":"{readStateIndex:5158; appliedIndex:5156; }","duration":"174.033433ms","start":"2026-08-04T15:25:43.216001Z","end":"2026-08-04T15:25:43.390035Z","steps":["trace[992015405] 'read index received' (duration: 84.689382ms)","trace[992015405] 'applied index is now lower than readState.Index' (duration: 89.342681ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:25:43.390163Z","caller":"traceutil/trace.go:171","msg":"trace[992054396] transaction","detail":"{read_only:false; response_revision:4967; number_of_response:1; }","duration":"187.372637ms","start":"2026-08-04T15:25:43.202747Z","end":"2026-08-04T15:25:43.39012Z","steps":["trace[992054396] 'process raft request' (duration: 187.023078ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:25:43.390373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.34496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:25:43.390462Z","caller":"traceutil/trace.go:171","msg":"trace[748172354] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4967; }","duration":"174.472983ms","start":"2026-08-04T15:25:43.215967Z","end":"2026-08-04T15:25:43.39044Z","steps":["trace[748172354] 'agreement among raft nodes before linearized reading' (duration: 174.256038ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:25:45.87071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.493213ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:25:45.870831Z","caller":"traceutil/trace.go:171","msg":"trace[1873760651] transaction","detail":"{read_only:false; response_revision:5106; number_of_response:1; }","duration":"376.531205ms","start":"2026-08-04T15:25:45.494281Z","end":"2026-08-04T15:25:45.870812Z","steps":["trace[1873760651] 'process raft request' (duration: 244.852928ms)","trace[1873760651] 'compare' (duration: 131.305778ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:25:45.8709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:25:45.494247Z","time spent":"376.623078ms","remote":"127.0.0.1:48430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:25:45.907707Z","caller":"traceutil/trace.go:171","msg":"trace[872174291] linearizableReadLoop","detail":"{readStateIndex:5299; appliedIndex:5297; }","duration":"349.579561ms","start":"2026-08-04T15:25:45.558095Z","end":"2026-08-04T15:25:45.907674Z","steps":["trace[872174291] 'read index received' (duration: 181.125289ms)","trace[872174291] 'applied index is now lower than readState.Index' (duration: 168.453082ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:25:45.907821Z","caller":"traceutil/trace.go:171","msg":"trace[227799568] transaction","detail":"{read_only:false; response_revision:5107; number_of_response:1; }","duration":"412.018209ms","start":"2026-08-04T15:25:45.495755Z","end":"2026-08-04T15:25:45.907773Z","steps":["trace[227799568] 'process raft request' (duration: 411.735803ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:25:45.907922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.797457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-04T15:25:45.908013Z","caller":"traceutil/trace.go:171","msg":"trace[40154230] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:5107; }","duration":"349.95642ms","start":"2026-08-04T15:25:45.558039Z","end":"2026-08-04T15:25:45.907996Z","steps":["trace[40154230] 'agreement among raft nodes before linearized reading' (duration: 349.770116ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:25:45.908055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:25:45.558018Z","time spent":"350.029342ms","remote":"127.0.0.1:48610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":9,"response size":30,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"warn","ts":"2026-08-04T15:25:45.908054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:25:45.495726Z","time spent":"412.197744ms","remote":"127.0.0.1:48430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T15:25:45.929895Z","caller":"traceutil/trace.go:171","msg":"trace[500227559] transaction","detail":"{read_only:false; response_revision:5108; number_of_response:1; }","duration":"180.421674ms","start":"2026-08-04T15:25:45.749439Z","end":"2026-08-04T15:25:45.92986Z","steps":["trace[500227559] 'process raft request' (duration: 180.083046ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:25:45.930001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.347449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f8b1714b-9fd5-43f9-b5ad-4647cc4cf4e5\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-08-04T15:25:45.930115Z","caller":"traceutil/trace.go:171","msg":"trace[829841578] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f8b1714b-9fd5-43f9-b5ad-4647cc4cf4e5; range_end:; response_count:1; response_revision:5109; }","duration":"259.524934ms","start":"2026-08-04T15:25:45.670562Z","end":"2026-08-04T15:25:45.930087Z","steps":["trace[829841578] 'agreement among raft nodes before linearized reading' (duration: 259.242917ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:25:45.930268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.757177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f8b1714b-9fd5-43f9-b5ad-4647cc4cf4e5\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-08-04T15:25:45.930353Z","caller":"traceutil/trace.go:171","msg":"trace[1298707111] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f8b1714b-9fd5-43f9-b5ad-4647cc4cf4e5; range_end:; response_count:1; response_revision:5109; }","duration":"179.857659ms","start":"2026-08-04T15:25:45.750473Z","end":"2026-08-04T15:25:45.93033Z","steps":["trace[1298707111] 'agreement among raft nodes before linearized reading' (duration: 179.606724ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:25:45.930358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.533818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:16476"} {"level":"info","ts":"2026-08-04T15:25:45.930467Z","caller":"traceutil/trace.go:171","msg":"trace[2093512625] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:5109; }","duration":"195.698032ms","start":"2026-08-04T15:25:45.734749Z","end":"2026-08-04T15:25:45.930447Z","steps":["trace[2093512625] 'agreement among raft nodes before linearized reading' (duration: 195.382375ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:25:48.218801Z","caller":"traceutil/trace.go:171","msg":"trace[1414982448] transaction","detail":"{read_only:false; response_revision:5146; number_of_response:1; }","duration":"130.847578ms","start":"2026-08-04T15:25:48.087936Z","end":"2026-08-04T15:25:48.218783Z","steps":["trace[1414982448] 'process raft request' (duration: 130.732335ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:25:48.325153Z","caller":"traceutil/trace.go:171","msg":"trace[1569613843] transaction","detail":"{read_only:false; response_revision:5148; number_of_response:1; }","duration":"236.421151ms","start":"2026-08-04T15:25:48.088712Z","end":"2026-08-04T15:25:48.325133Z","steps":["trace[1569613843] 'process raft request' (duration: 236.35978ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:25:48.325153Z","caller":"traceutil/trace.go:171","msg":"trace[754402592] transaction","detail":"{read_only:false; response_revision:5147; number_of_response:1; }","duration":"236.422911ms","start":"2026-08-04T15:25:48.088699Z","end":"2026-08-04T15:25:48.325122Z","steps":["trace[754402592] 'process raft request' (duration: 236.200466ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:25:48.325323Z","caller":"traceutil/trace.go:171","msg":"trace[21698236] linearizableReadLoop","detail":"{readStateIndex:5344; appliedIndex:5340; }","duration":"123.622127ms","start":"2026-08-04T15:25:48.20169Z","end":"2026-08-04T15:25:48.325313Z","steps":["trace[21698236] 'read index received' (duration: 17.03505ms)","trace[21698236] 'applied index is now lower than readState.Index' (duration: 106.585267ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:25:48.325462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.763601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/goldpinger\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:25:48.325489Z","caller":"traceutil/trace.go:171","msg":"trace[1319491624] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/goldpinger; range_end:; response_count:0; response_revision:5149; }","duration":"123.852663ms","start":"2026-08-04T15:25:48.20163Z","end":"2026-08-04T15:25:48.325482Z","steps":["trace[1319491624] 'agreement among raft nodes before linearized reading' (duration: 123.768371ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:25:48.325455Z","caller":"traceutil/trace.go:171","msg":"trace[322094121] transaction","detail":"{read_only:false; response_revision:5149; number_of_response:1; }","duration":"236.685776ms","start":"2026-08-04T15:25:48.088722Z","end":"2026-08-04T15:25:48.325408Z","steps":["trace[322094121] 'process raft request' (duration: 236.380269ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:25:48.32567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.593668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:25:48.325777Z","caller":"traceutil/trace.go:171","msg":"trace[1174696425] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5149; }","duration":"112.790152ms","start":"2026-08-04T15:25:48.212962Z","end":"2026-08-04T15:25:48.325753Z","steps":["trace[1174696425] 'agreement among raft nodes before linearized reading' (duration: 112.550087ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:25:56.117786Z","caller":"traceutil/trace.go:171","msg":"trace[327666665] transaction","detail":"{read_only:false; response_revision:5300; number_of_response:1; }","duration":"170.810667ms","start":"2026-08-04T15:25:55.946951Z","end":"2026-08-04T15:25:56.117762Z","steps":["trace[327666665] 'process raft request' (duration: 169.23612ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:25:56.118145Z","caller":"traceutil/trace.go:171","msg":"trace[1394534438] linearizableReadLoop","detail":"{readStateIndex:5504; appliedIndex:5499; }","duration":"159.678275ms","start":"2026-08-04T15:25:55.958448Z","end":"2026-08-04T15:25:56.118126Z","steps":["trace[1394534438] 'read index received' (duration: 157.743329ms)","trace[1394534438] 'applied index is now lower than readState.Index' (duration: 1.934016ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:25:56.118247Z","caller":"traceutil/trace.go:171","msg":"trace[2047234205] transaction","detail":"{read_only:false; response_revision:5302; number_of_response:1; }","duration":"170.48647ms","start":"2026-08-04T15:25:55.947751Z","end":"2026-08-04T15:25:56.118237Z","steps":["trace[2047234205] 'process raft request' (duration: 170.177272ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:25:56.118054Z","caller":"traceutil/trace.go:171","msg":"trace[449476340] transaction","detail":"{read_only:false; response_revision:5301; number_of_response:1; }","duration":"170.453359ms","start":"2026-08-04T15:25:55.947573Z","end":"2026-08-04T15:25:56.118026Z","steps":["trace[449476340] 'process raft request' (duration: 170.143391ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:25:56.118413Z","caller":"traceutil/trace.go:171","msg":"trace[335514203] transaction","detail":"{read_only:false; response_revision:5303; number_of_response:1; }","duration":"169.392204ms","start":"2026-08-04T15:25:55.948981Z","end":"2026-08-04T15:25:56.118373Z","steps":["trace[335514203] 'process raft request' (duration: 169.032716ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:25:56.118743Z","caller":"traceutil/trace.go:171","msg":"trace[512398581] transaction","detail":"{read_only:false; response_revision:5305; number_of_response:1; }","duration":"153.024079ms","start":"2026-08-04T15:25:55.965709Z","end":"2026-08-04T15:25:56.118733Z","steps":["trace[512398581] 'process raft request' (duration: 152.389325ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:25:56.118366Z","caller":"traceutil/trace.go:171","msg":"trace[1038399622] transaction","detail":"{read_only:false; response_revision:5304; number_of_response:1; }","duration":"169.115378ms","start":"2026-08-04T15:25:55.949227Z","end":"2026-08-04T15:25:56.118343Z","steps":["trace[1038399622] 'process raft request' (duration: 168.823011ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:25:56.118912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.835582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-08-04T15:25:56.119151Z","caller":"traceutil/trace.go:171","msg":"trace[512503914] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5305; }","duration":"175.150659ms","start":"2026-08-04T15:25:55.943977Z","end":"2026-08-04T15:25:56.119127Z","steps":["trace[512503914] 'agreement among raft nodes before linearized reading' (duration: 174.239128ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:25:59.551553Z","caller":"traceutil/trace.go:171","msg":"trace[1413734382] transaction","detail":"{read_only:false; response_revision:5365; number_of_response:1; }","duration":"178.372935ms","start":"2026-08-04T15:25:59.373151Z","end":"2026-08-04T15:25:59.551524Z","steps":["trace[1413734382] 'process raft request' (duration: 178.025197ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:25:59.726604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.750186ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:25:59.726844Z","caller":"traceutil/trace.go:171","msg":"trace[1015756322] transaction","detail":"{read_only:false; response_revision:5366; number_of_response:1; }","duration":"182.42679ms","start":"2026-08-04T15:25:59.544384Z","end":"2026-08-04T15:25:59.72681Z","steps":["trace[1015756322] 'process raft request' (duration: 45.370427ms)","trace[1015756322] 'compare' (duration: 136.563081ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:25:59.72688Z","caller":"traceutil/trace.go:171","msg":"trace[1555874608] transaction","detail":"{read_only:false; response_revision:5367; number_of_response:1; }","duration":"173.582783ms","start":"2026-08-04T15:25:59.553263Z","end":"2026-08-04T15:25:59.726846Z","steps":["trace[1555874608] 'process raft request' (duration: 173.46054ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:25:59.727141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.396332ms","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-08-04T15:25:59.726974Z","caller":"traceutil/trace.go:171","msg":"trace[965413009] linearizableReadLoop","detail":"{readStateIndex:5569; appliedIndex:5567; }","duration":"123.218218ms","start":"2026-08-04T15:25:59.603727Z","end":"2026-08-04T15:25:59.726945Z","steps":["trace[965413009] 'read index received' (duration: 117.497723ms)","trace[965413009] 'applied index is now lower than readState.Index' (duration: 5.718005ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:25:59.727199Z","caller":"traceutil/trace.go:171","msg":"trace[1223427780] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:5368; }","duration":"123.509504ms","start":"2026-08-04T15:25:59.603677Z","end":"2026-08-04T15:25:59.727186Z","steps":["trace[1223427780] 'agreement among raft nodes before linearized reading' (duration: 123.353851ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:26:09.171883Z","caller":"traceutil/trace.go:171","msg":"trace[1737819467] linearizableReadLoop","detail":"{readStateIndex:5759; appliedIndex:5758; }","duration":"151.83794ms","start":"2026-08-04T15:26:09.020024Z","end":"2026-08-04T15:26:09.171862Z","steps":["trace[1737819467] 'read index received' (duration: 151.657616ms)","trace[1737819467] 'applied index is now lower than readState.Index' (duration: 179.224µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:26:09.172015Z","caller":"traceutil/trace.go:171","msg":"trace[1298338637] transaction","detail":"{read_only:false; response_revision:5555; number_of_response:1; }","duration":"220.271529ms","start":"2026-08-04T15:26:08.951713Z","end":"2026-08-04T15:26:09.171985Z","steps":["trace[1298338637] 'process raft request' (duration: 219.995502ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:26:09.172073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.030294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5728e19d-4fb1-4505-91ca-ac9a669fd43f\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-08-04T15:26:09.172106Z","caller":"traceutil/trace.go:171","msg":"trace[403581492] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5728e19d-4fb1-4505-91ca-ac9a669fd43f; range_end:; response_count:1; response_revision:5555; }","duration":"152.080075ms","start":"2026-08-04T15:26:09.020016Z","end":"2026-08-04T15:26:09.172096Z","steps":["trace[403581492] 'agreement among raft nodes before linearized reading' (duration: 151.926442ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:26:11.404888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.477975ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:26:11.405007Z","caller":"traceutil/trace.go:171","msg":"trace[895126995] linearizableReadLoop","detail":"{readStateIndex:5811; appliedIndex:5810; }","duration":"228.516884ms","start":"2026-08-04T15:26:11.17647Z","end":"2026-08-04T15:26:11.404987Z","steps":["trace[895126995] 'read index received' (duration: 78.747452ms)","trace[895126995] 'applied index is now lower than readState.Index' (duration: 149.768052ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:26:11.405207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.101016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-04T15:26:11.405308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.815212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-08-04T15:26:11.405355Z","caller":"traceutil/trace.go:171","msg":"trace[988937593] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5605; }","duration":"191.27467ms","start":"2026-08-04T15:26:11.214051Z","end":"2026-08-04T15:26:11.405325Z","steps":["trace[988937593] 'agreement among raft nodes before linearized reading' (duration: 191.060655ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:26:11.405395Z","caller":"traceutil/trace.go:171","msg":"trace[1893670582] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5605; }","duration":"228.943945ms","start":"2026-08-04T15:26:11.17643Z","end":"2026-08-04T15:26:11.405374Z","steps":["trace[1893670582] 'agreement among raft nodes before linearized reading' (duration: 228.667568ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:26:11.405406Z","caller":"traceutil/trace.go:171","msg":"trace[767799101] transaction","detail":"{read_only:false; response_revision:5605; number_of_response:1; }","duration":"311.927246ms","start":"2026-08-04T15:26:11.093431Z","end":"2026-08-04T15:26:11.405358Z","steps":["trace[767799101] 'process raft request' (duration: 161.805065ms)","trace[767799101] 'compare' (duration: 149.315422ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:26:11.405559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:26:11.093408Z","time spent":"312.07874ms","remote":"127.0.0.1:48266","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4771,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:26:11.406399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.219125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2225408"} {"level":"info","ts":"2026-08-04T15:26:11.406458Z","caller":"traceutil/trace.go:171","msg":"trace[991553427] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:5605; }","duration":"105.314627ms","start":"2026-08-04T15:26:11.301128Z","end":"2026-08-04T15:26:11.406443Z","steps":["trace[991553427] 'agreement among raft nodes before linearized reading' (duration: 104.241063ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:26:57.947019Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2990} {"level":"info","ts":"2026-08-04T15:26:58.021321Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2990,"took":"72.609401ms","hash":1080230009,"current-db-size-bytes":59400192,"current-db-size":"59 MB","current-db-size-in-use-bytes":33894400,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-08-04T15:26:58.021395Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1080230009,"revision":2990,"compact-revision":-1} {"level":"info","ts":"2026-08-04T15:31:57.95522Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6037} {"level":"info","ts":"2026-08-04T15:31:58.068902Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6037,"took":"110.690451ms","hash":2598522722,"current-db-size-bytes":59400192,"current-db-size":"59 MB","current-db-size-in-use-bytes":21942272,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-08-04T15:31:58.068991Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2598522722,"revision":6037,"compact-revision":2990} {"level":"info","ts":"2026-08-04T15:32:32.695325Z","caller":"traceutil/trace.go:171","msg":"trace[1391325173] linearizableReadLoop","detail":"{readStateIndex:8774; appliedIndex:8773; }","duration":"195.520348ms","start":"2026-08-04T15:32:32.499773Z","end":"2026-08-04T15:32:32.695294Z","steps":["trace[1391325173] 'read index received' (duration: 195.332284ms)","trace[1391325173] 'applied index is now lower than readState.Index' (duration: 186.624µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:32:32.695449Z","caller":"traceutil/trace.go:171","msg":"trace[1506207299] transaction","detail":"{read_only:false; response_revision:8474; number_of_response:1; }","duration":"202.601134ms","start":"2026-08-04T15:32:32.492783Z","end":"2026-08-04T15:32:32.695384Z","steps":["trace[1506207299] 'process raft request' (duration: 202.288307ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:32:32.695677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.873236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-08-04T15:32:32.695775Z","caller":"traceutil/trace.go:171","msg":"trace[2144504725] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8474; }","duration":"195.988169ms","start":"2026-08-04T15:32:32.499767Z","end":"2026-08-04T15:32:32.695755Z","steps":["trace[2144504725] 'agreement among raft nodes before linearized reading' (duration: 195.715852ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:32:32.696156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.662418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-08-04T15:32:32.696209Z","caller":"traceutil/trace.go:171","msg":"trace[1029167650] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8475; }","duration":"159.790321ms","start":"2026-08-04T15:32:32.536408Z","end":"2026-08-04T15:32:32.696199Z","steps":["trace[1029167650] 'agreement among raft nodes before linearized reading' (duration: 159.599476ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:32:32.696425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.825352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-08-04T15:32:32.697132Z","caller":"traceutil/trace.go:171","msg":"trace[2077470201] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8475; }","duration":"160.636041ms","start":"2026-08-04T15:32:32.536471Z","end":"2026-08-04T15:32:32.697107Z","steps":["trace[2077470201] 'agreement among raft nodes before linearized reading' (duration: 159.697369ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:32:44.273264Z","caller":"traceutil/trace.go:171","msg":"trace[1009255215] transaction","detail":"{read_only:false; response_revision:8537; number_of_response:1; }","duration":"149.399679ms","start":"2026-08-04T15:32:44.123825Z","end":"2026-08-04T15:32:44.273225Z","steps":["trace[1009255215] 'process raft request' (duration: 149.069191ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:32:44.828837Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002289.wal"} {"level":"info","ts":"2026-08-04T15:32:44.829968Z","caller":"traceutil/trace.go:171","msg":"trace[253240779] transaction","detail":"{read_only:false; response_revision:8538; number_of_response:1; }","duration":"107.365923ms","start":"2026-08-04T15:32:44.722561Z","end":"2026-08-04T15:32:44.829926Z","steps":["trace[253240779] 'process raft request' (duration: 106.766429ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:32:45.43157Z","caller":"traceutil/trace.go:171","msg":"trace[1404270874] transaction","detail":"{read_only:false; response_revision:8543; number_of_response:1; }","duration":"156.520464ms","start":"2026-08-04T15:32:45.274972Z","end":"2026-08-04T15:32:45.431493Z","steps":["trace[1404270874] 'process raft request' (duration: 126.993274ms)","trace[1404270874] 'compare' (duration: 29.396607ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:32:45.564154Z","caller":"traceutil/trace.go:171","msg":"trace[348481129] transaction","detail":"{read_only:false; response_revision:8544; number_of_response:1; }","duration":"100.970043ms","start":"2026-08-04T15:32:45.463153Z","end":"2026-08-04T15:32:45.564123Z","steps":["trace[348481129] 'process raft request' (duration: 67.679085ms)","trace[348481129] 'compare' (duration: 33.168696ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:32:46.580377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.025658ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-04T15:33:11.191793Z","caller":"traceutil/trace.go:171","msg":"trace[871275547] transaction","detail":"{read_only:false; response_revision:8730; number_of_response:1; }","duration":"104.306868ms","start":"2026-08-04T15:33:11.087442Z","end":"2026-08-04T15:33:11.191749Z","steps":["trace[871275547] 'process raft request' (duration: 104.015862ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:33:14.621263Z","caller":"traceutil/trace.go:171","msg":"trace[268065819] transaction","detail":"{read_only:false; response_revision:8754; number_of_response:1; }","duration":"322.081807ms","start":"2026-08-04T15:33:14.299161Z","end":"2026-08-04T15:33:14.621243Z","steps":["trace[268065819] 'process raft request' (duration: 321.945914ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:33:14.62138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:33:14.299128Z","time spent":"322.19093ms","remote":"127.0.0.1:48430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:33:14.88925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.948972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-04T15:33:14.889494Z","caller":"traceutil/trace.go:171","msg":"trace[1380872902] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8754; }","duration":"170.207498ms","start":"2026-08-04T15:33:14.71919Z","end":"2026-08-04T15:33:14.889398Z","steps":["trace[1380872902] 'count revisions from in-memory index tree' (duration: 169.82866ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:33:17.998485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.393667ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:33:17.998745Z","caller":"traceutil/trace.go:171","msg":"trace[1966017307] transaction","detail":"{read_only:false; response_revision:8771; number_of_response:1; }","duration":"149.584157ms","start":"2026-08-04T15:33:17.849125Z","end":"2026-08-04T15:33:17.998709Z","steps":["trace[1966017307] 'process raft request' (duration: 21.854641ms)","trace[1966017307] 'compare' (duration: 127.223963ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:33:27.344064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.726576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:33:27.344168Z","caller":"traceutil/trace.go:171","msg":"trace[575319180] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8860; }","duration":"127.903369ms","start":"2026-08-04T15:33:27.216242Z","end":"2026-08-04T15:33:27.344145Z","steps":["trace[575319180] 'range keys from in-memory index tree' (duration: 127.606303ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:33:27.578499Z","caller":"traceutil/trace.go:171","msg":"trace[1713572675] linearizableReadLoop","detail":"{readStateIndex:9179; appliedIndex:9178; }","duration":"228.403518ms","start":"2026-08-04T15:33:27.350056Z","end":"2026-08-04T15:33:27.57846Z","steps":["trace[1713572675] 'read index received' (duration: 228.300936ms)","trace[1713572675] 'applied index is now lower than readState.Index' (duration: 100.662µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:33:27.578554Z","caller":"traceutil/trace.go:171","msg":"trace[547951508] transaction","detail":"{read_only:false; response_revision:8861; number_of_response:1; }","duration":"229.019682ms","start":"2026-08-04T15:33:27.349488Z","end":"2026-08-04T15:33:27.578507Z","steps":["trace[547951508] 'process raft request' (duration: 228.796307ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:33:27.578801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.719645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-08-04T15:33:27.57885Z","caller":"traceutil/trace.go:171","msg":"trace[1628908016] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8861; }","duration":"228.799197ms","start":"2026-08-04T15:33:27.350039Z","end":"2026-08-04T15:33:27.578838Z","steps":["trace[1628908016] 'agreement among raft nodes before linearized reading' (duration: 228.601482ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:33:27.593643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.499461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-08-04T15:33:27.593612Z","caller":"traceutil/trace.go:171","msg":"trace[970624883] transaction","detail":"{read_only:false; response_revision:8862; number_of_response:1; }","duration":"243.482521ms","start":"2026-08-04T15:33:27.350085Z","end":"2026-08-04T15:33:27.593567Z","steps":["trace[970624883] 'process raft request' (duration: 243.307897ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:33:27.593729Z","caller":"traceutil/trace.go:171","msg":"trace[640401577] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8862; }","duration":"243.617024ms","start":"2026-08-04T15:33:27.350093Z","end":"2026-08-04T15:33:27.59371Z","steps":["trace[640401577] 'agreement among raft nodes before linearized reading' (duration: 243.421489ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:33:28.737212Z","caller":"traceutil/trace.go:171","msg":"trace[1256154155] transaction","detail":"{read_only:false; response_revision:8872; number_of_response:1; }","duration":"165.090148ms","start":"2026-08-04T15:33:28.572076Z","end":"2026-08-04T15:33:28.737166Z","steps":["trace[1256154155] 'process raft request' (duration: 164.788861ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:33:28.864987Z","caller":"traceutil/trace.go:171","msg":"trace[939759378] transaction","detail":"{read_only:false; response_revision:8873; number_of_response:1; }","duration":"112.678534ms","start":"2026-08-04T15:33:28.752247Z","end":"2026-08-04T15:33:28.864925Z","steps":["trace[939759378] 'process raft request' (duration: 86.925102ms)","trace[939759378] 'compare' (duration: 24.759539ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:34:48.445726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.654302ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T15:34:48.446169Z","caller":"traceutil/trace.go:171","msg":"trace[1041715097] transaction","detail":"{read_only:false; response_revision:9638; number_of_response:1; }","duration":"242.934918ms","start":"2026-08-04T15:34:48.20301Z","end":"2026-08-04T15:34:48.445944Z","steps":["trace[1041715097] 'process raft request' (duration: 242.844475ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:34:48.446346Z","caller":"traceutil/trace.go:171","msg":"trace[1768591321] transaction","detail":"{read_only:false; response_revision:9637; number_of_response:1; }","duration":"403.192553ms","start":"2026-08-04T15:34:48.043071Z","end":"2026-08-04T15:34:48.446263Z","steps":["trace[1768591321] 'process raft request' (duration: 227.898156ms)","trace[1768591321] 'compare' (duration: 174.54407ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:34:48.446382Z","caller":"traceutil/trace.go:171","msg":"trace[1854434252] linearizableReadLoop","detail":"{readStateIndex:9977; appliedIndex:9976; }","duration":"394.332616ms","start":"2026-08-04T15:34:48.052004Z","end":"2026-08-04T15:34:48.446337Z","steps":["trace[1854434252] 'read index received' (duration: 218.978508ms)","trace[1854434252] 'applied index is now lower than readState.Index' (duration: 175.345947ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T15:34:48.446617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:34:48.043047Z","time spent":"403.43868ms","remote":"127.0.0.1:48430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T15:34:48.446723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.696945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-04T15:34:48.446812Z","caller":"traceutil/trace.go:171","msg":"trace[1213445814] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9638; }","duration":"394.817247ms","start":"2026-08-04T15:34:48.051981Z","end":"2026-08-04T15:34:48.446798Z","steps":["trace[1213445814] 'agreement among raft nodes before linearized reading' (duration: 394.52528ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:34:48.446879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T15:34:48.051965Z","time spent":"394.90229ms","remote":"127.0.0.1:48430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-04T15:34:48.512206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.032592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T15:34:48.512195Z","caller":"traceutil/trace.go:171","msg":"trace[595119570] transaction","detail":"{read_only:false; response_revision:9639; number_of_response:1; }","duration":"101.301158ms","start":"2026-08-04T15:34:48.410827Z","end":"2026-08-04T15:34:48.512128Z","steps":["trace[595119570] 'process raft request' (duration: 101.091013ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:34:48.51234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.111998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-04T15:34:48.512474Z","caller":"traceutil/trace.go:171","msg":"trace[2033269972] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:9640; }","duration":"156.284332ms","start":"2026-08-04T15:34:48.356138Z","end":"2026-08-04T15:34:48.512423Z","steps":["trace[2033269972] 'agreement among raft nodes before linearized reading' (duration: 156.065337ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:34:48.512296Z","caller":"traceutil/trace.go:171","msg":"trace[1817456843] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9640; }","duration":"297.190726ms","start":"2026-08-04T15:34:48.215086Z","end":"2026-08-04T15:34:48.512276Z","steps":["trace[1817456843] 'agreement among raft nodes before linearized reading' (duration: 297.014862ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T15:34:48.512611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.599281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-08-04T15:34:48.51268Z","caller":"traceutil/trace.go:171","msg":"trace[1465963363] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9640; }","duration":"171.702963ms","start":"2026-08-04T15:34:48.340969Z","end":"2026-08-04T15:34:48.512672Z","steps":["trace[1465963363] 'agreement among raft nodes before linearized reading' (duration: 171.436497ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:34:48.625145Z","caller":"traceutil/trace.go:171","msg":"trace[2038959624] transaction","detail":"{read_only:false; response_revision:9642; number_of_response:1; }","duration":"108.027404ms","start":"2026-08-04T15:34:48.517091Z","end":"2026-08-04T15:34:48.625118Z","steps":["trace[2038959624] 'process raft request' (duration: 107.922962ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T15:34:48.625162Z","caller":"traceutil/trace.go:171","msg":"trace[1046258008] transaction","detail":"{read_only:false; response_revision:9641; number_of_response:1; }","duration":"173.379652ms","start":"2026-08-04T15:34:48.451729Z","end":"2026-08-04T15:34:48.625108Z","steps":["trace[1046258008] 'process raft request' (duration: 114.758212ms)","trace[1046258008] 'compare' (duration: 58.411945ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T15:34:52.037847Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"e9047e95cdba2056","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-04T15:34:52.044879Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-08-04T15:34:52.045075Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-08-04T15:36:57.966945Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8117} {"level":"info","ts":"2026-08-04T15:36:58.032418Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8117,"took":"62.970249ms","hash":2626716046,"current-db-size-bytes":59400192,"current-db-size":"59 MB","current-db-size-in-use-bytes":28172288,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-08-04T15:36:58.032478Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2626716046,"revision":8117,"compact-revision":6037}