{"level":"warn","ts":"2026-04-21T17:05:01.546356Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-21T17:05:01.546427Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.25: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.25:2380","--initial-cluster=instance=https://199.19.213.25:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.25:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.25: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-04-21T17:05:01.546497Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-21T17:05:01.54655Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.25:2380"]} {"level":"info","ts":"2026-04-21T17:05:01.546569Z","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-04-21T17:05:01.547248Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.25:2379"]} {"level":"info","ts":"2026-04-21T17:05:01.547325Z","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":8,"max-cpu-available":8,"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.25:2380"],"listen-peer-urls":["https://199.19.213.25:2380"],"advertise-client-urls":["https://199.19.213.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.25: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-04-21T17:05:01.552921Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.400858ms"} {"level":"info","ts":"2026-04-21T17:05:01.696113Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9bd4db28c48efaf1","cluster-id":"b621f59192c78404"} {"level":"info","ts":"2026-04-21T17:05:01.696223Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 switched to configuration voters=()"} {"level":"info","ts":"2026-04-21T17:05:01.696391Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became follower at term 0"} {"level":"info","ts":"2026-04-21T17:05:01.696434Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9bd4db28c48efaf1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-21T17:05:01.696458Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became follower at term 1"} {"level":"info","ts":"2026-04-21T17:05:01.696584Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 switched to configuration voters=(11228840739084368625)"} {"level":"warn","ts":"2026-04-21T17:05:01.766852Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-21T17:05:01.940555Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-21T17:05:01.941792Z","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-04-21T17:05:01.943929Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9bd4db28c48efaf1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-21T17:05:01.944189Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9bd4db28c48efaf1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-21T17:05:01.944385Z","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-04-21T17:05:01.944475Z","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-04-21T17:05:01.944499Z","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-04-21T17:05:01.9466Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 switched to configuration voters=(11228840739084368625)"} {"level":"info","ts":"2026-04-21T17:05:01.94831Z","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-04-21T17:05:01.94852Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.25:2380"} {"level":"info","ts":"2026-04-21T17:05:01.948582Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.25:2380"} {"level":"info","ts":"2026-04-21T17:05:01.948598Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9bd4db28c48efaf1","initial-advertise-peer-urls":["https://199.19.213.25:2380"],"listen-peer-urls":["https://199.19.213.25:2380"],"advertise-client-urls":["https://199.19.213.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-21T17:05:01.948667Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-21T17:05:01.948923Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b621f59192c78404","local-member-id":"9bd4db28c48efaf1","added-peer-id":"9bd4db28c48efaf1","added-peer-peer-urls":["https://199.19.213.25:2380"]} {"level":"info","ts":"2026-04-21T17:05:02.299629Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 is starting a new election at term 1"} {"level":"info","ts":"2026-04-21T17:05:02.299708Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-21T17:05:02.299747Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 received MsgPreVoteResp from 9bd4db28c48efaf1 at term 1"} {"level":"info","ts":"2026-04-21T17:05:02.299771Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became candidate at term 2"} {"level":"info","ts":"2026-04-21T17:05:02.299782Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 received MsgVoteResp from 9bd4db28c48efaf1 at term 2"} {"level":"info","ts":"2026-04-21T17:05:02.299798Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd4db28c48efaf1 became leader at term 2"} {"level":"info","ts":"2026-04-21T17:05:02.299823Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9bd4db28c48efaf1 elected leader 9bd4db28c48efaf1 at term 2"} {"level":"info","ts":"2026-04-21T17:05:02.300757Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9bd4db28c48efaf1","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.25:2379]}","request-path":"/0/members/9bd4db28c48efaf1/attributes","cluster-id":"b621f59192c78404","publish-timeout":"7s"} {"level":"info","ts":"2026-04-21T17:05:02.300791Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T17:05:02.30082Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T17:05:02.30099Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T17:05:02.30149Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-21T17:05:02.30154Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-21T17:05:02.304387Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.25:2379"} {"level":"info","ts":"2026-04-21T17:05:02.304498Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-21T17:05:02.307254Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b621f59192c78404","local-member-id":"9bd4db28c48efaf1","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T17:05:02.307373Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T17:05:02.307419Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-04-21T17:05:09.569706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.094658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"warn","ts":"2026-04-21T17:05:09.56972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.552677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-21T17:05:09.569878Z","caller":"traceutil/trace.go:171","msg":"trace[1429974460] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:283; }","duration":"255.339978ms","start":"2026-04-21T17:05:09.314515Z","end":"2026-04-21T17:05:09.569855Z","steps":["trace[1429974460] 'range keys from in-memory index tree' (duration: 255.005171ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:05:09.569913Z","caller":"traceutil/trace.go:171","msg":"trace[1866288142] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:283; }","duration":"249.84167ms","start":"2026-04-21T17:05:09.320041Z","end":"2026-04-21T17:05:09.569883Z","steps":["trace[1866288142] 'range keys from in-memory index tree' (duration: 249.443431ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:05:09.736278Z","caller":"traceutil/trace.go:171","msg":"trace[1976733160] transaction","detail":"{read_only:false; response_revision:284; number_of_response:1; }","duration":"162.213963ms","start":"2026-04-21T17:05:09.574041Z","end":"2026-04-21T17:05:09.736255Z","steps":["trace[1976733160] 'process raft request' (duration: 162.089453ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:05:09.763829Z","caller":"traceutil/trace.go:171","msg":"trace[594541684] linearizableReadLoop","detail":"{readStateIndex:298; appliedIndex:296; }","duration":"116.434138ms","start":"2026-04-21T17:05:09.647366Z","end":"2026-04-21T17:05:09.7638Z","steps":["trace[594541684] 'read index received' (duration: 88.861629ms)","trace[594541684] 'applied index is now lower than readState.Index' (duration: 27.571129ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:05:09.764023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.640653ms","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-04-21T17:05:09.764072Z","caller":"traceutil/trace.go:171","msg":"trace[788604081] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:285; }","duration":"116.772243ms","start":"2026-04-21T17:05:09.647285Z","end":"2026-04-21T17:05:09.764057Z","steps":["trace[788604081] 'agreement among raft nodes before linearized reading' (duration: 116.669646ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:05:09.764135Z","caller":"traceutil/trace.go:171","msg":"trace[30354179] transaction","detail":"{read_only:false; response_revision:285; number_of_response:1; }","duration":"189.736487ms","start":"2026-04-21T17:05:09.574269Z","end":"2026-04-21T17:05:09.764005Z","steps":["trace[30354179] 'process raft request' (duration: 189.327117ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:05:09.764435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.548608ms","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-04-21T17:05:09.764475Z","caller":"traceutil/trace.go:171","msg":"trace[1740695434] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:285; }","duration":"114.618434ms","start":"2026-04-21T17:05:09.649847Z","end":"2026-04-21T17:05:09.764466Z","steps":["trace[1740695434] 'agreement among raft nodes before linearized reading' (duration: 114.558059ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:05:09.764241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.847201ms","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-04-21T17:05:09.764597Z","caller":"traceutil/trace.go:171","msg":"trace[1289031849] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:285; }","duration":"115.232669ms","start":"2026-04-21T17:05:09.649333Z","end":"2026-04-21T17:05:09.764565Z","steps":["trace[1289031849] 'agreement among raft nodes before linearized reading' (duration: 114.878183ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:05:33.212067Z","caller":"traceutil/trace.go:171","msg":"trace[431173780] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"126.641847ms","start":"2026-04-21T17:05:33.085408Z","end":"2026-04-21T17:05:33.212049Z","steps":["trace[431173780] 'process raft request' (duration: 126.618576ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:05:33.212202Z","caller":"traceutil/trace.go:171","msg":"trace[722236564] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"126.809221ms","start":"2026-04-21T17:05:33.085388Z","end":"2026-04-21T17:05:33.212197Z","steps":["trace[722236564] 'process raft request' (duration: 126.599915ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:05:33.212243Z","caller":"traceutil/trace.go:171","msg":"trace[370698608] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"126.836183ms","start":"2026-04-21T17:05:33.085401Z","end":"2026-04-21T17:05:33.212238Z","steps":["trace[370698608] 'process raft request' (duration: 126.601435ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:05:33.212327Z","caller":"traceutil/trace.go:171","msg":"trace[32244720] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"128.046343ms","start":"2026-04-21T17:05:33.084242Z","end":"2026-04-21T17:05:33.212288Z","steps":["trace[32244720] 'process raft request' (duration: 127.623852ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:05:33.215033Z","caller":"traceutil/trace.go:171","msg":"trace[125874390] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"129.676325ms","start":"2026-04-21T17:05:33.085332Z","end":"2026-04-21T17:05:33.215008Z","steps":["trace[125874390] 'process raft request' (duration: 126.634298ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:05:33.222853Z","caller":"traceutil/trace.go:171","msg":"trace[1005888490] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"100.434614ms","start":"2026-04-21T17:05:33.122402Z","end":"2026-04-21T17:05:33.222837Z","steps":["trace[1005888490] 'process raft request' (duration: 100.367268ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:05:33.223094Z","caller":"traceutil/trace.go:171","msg":"trace[396272934] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"132.923699ms","start":"2026-04-21T17:05:33.090163Z","end":"2026-04-21T17:05:33.223087Z","steps":["trace[396272934] 'process raft request' (duration: 132.336934ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:05:33.223168Z","caller":"traceutil/trace.go:171","msg":"trace[1865782233] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"132.922508ms","start":"2026-04-21T17:05:33.09024Z","end":"2026-04-21T17:05:33.223162Z","steps":["trace[1865782233] 'process raft request' (duration: 132.356796ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:05:33.223232Z","caller":"traceutil/trace.go:171","msg":"trace[1417587178] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"132.843863ms","start":"2026-04-21T17:05:33.090382Z","end":"2026-04-21T17:05:33.223226Z","steps":["trace[1417587178] 'process raft request' (duration: 132.242678ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:05:33.223291Z","caller":"traceutil/trace.go:171","msg":"trace[16774041] transaction","detail":"{read_only:false; number_of_response:0; response_revision:485; }","duration":"125.384644ms","start":"2026-04-21T17:05:33.097902Z","end":"2026-04-21T17:05:33.223287Z","steps":["trace[16774041] 'process raft request' (duration: 124.742626ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:05:33.22336Z","caller":"traceutil/trace.go:171","msg":"trace[1764721634] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"125.359702ms","start":"2026-04-21T17:05:33.097995Z","end":"2026-04-21T17:05:33.223355Z","steps":["trace[1764721634] 'process raft request' (duration: 124.673401ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:05:33.22342Z","caller":"traceutil/trace.go:171","msg":"trace[924199644] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"125.34035ms","start":"2026-04-21T17:05:33.098075Z","end":"2026-04-21T17:05:33.223415Z","steps":["trace[924199644] 'process raft request' (duration: 124.632988ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:05:33.223472Z","caller":"traceutil/trace.go:171","msg":"trace[755839146] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"121.291757ms","start":"2026-04-21T17:05:33.102175Z","end":"2026-04-21T17:05:33.223466Z","steps":["trace[755839146] 'process raft request' (duration: 120.562612ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:05:33.419316Z","caller":"traceutil/trace.go:171","msg":"trace[939262862] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"113.945016ms","start":"2026-04-21T17:05:33.305351Z","end":"2026-04-21T17:05:33.419296Z","steps":["trace[939262862] 'process raft request' (duration: 108.77919ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:05:33.419778Z","caller":"traceutil/trace.go:171","msg":"trace[865617373] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"109.673347ms","start":"2026-04-21T17:05:33.310087Z","end":"2026-04-21T17:05:33.41976Z","steps":["trace[865617373] 'process raft request' (duration: 109.341672ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:05:33.420046Z","caller":"traceutil/trace.go:171","msg":"trace[862174333] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"106.145783ms","start":"2026-04-21T17:05:33.313874Z","end":"2026-04-21T17:05:33.42002Z","steps":["trace[862174333] 'process raft request' (duration: 105.692339ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:05:39.140523Z","caller":"traceutil/trace.go:171","msg":"trace[779699322] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"218.62918ms","start":"2026-04-21T17:05:38.92187Z","end":"2026-04-21T17:05:39.140499Z","steps":["trace[779699322] 'process raft request' (duration: 218.014773ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:05:39.535533Z","caller":"traceutil/trace.go:171","msg":"trace[166330295] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"334.235596ms","start":"2026-04-21T17:05:39.201263Z","end":"2026-04-21T17:05:39.535499Z","steps":["trace[166330295] 'process raft request' (duration: 334.062793ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:05:39.536145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:05:39.201242Z","time spent":"334.380936ms","remote":"127.0.0.1:51220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:05:39.966258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.578123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:05:39.966338Z","caller":"traceutil/trace.go:171","msg":"trace[435200868] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:581; }","duration":"389.695132ms","start":"2026-04-21T17:05:39.576624Z","end":"2026-04-21T17:05:39.966319Z","steps":["trace[435200868] 'range keys from in-memory index tree' (duration: 389.509798ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:05:39.966339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.747806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jskw4\" ","response":"range_response_count:1 size:16961"} {"level":"warn","ts":"2026-04-21T17:05:39.966376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:05:39.576609Z","time spent":"389.759016ms","remote":"127.0.0.1:50710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-21T17:05:39.96639Z","caller":"traceutil/trace.go:171","msg":"trace[451913994] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jskw4; range_end:; response_count:1; response_revision:581; }","duration":"217.840084ms","start":"2026-04-21T17:05:39.748537Z","end":"2026-04-21T17:05:39.966377Z","steps":["trace[451913994] 'range keys from in-memory index tree' (duration: 217.616357ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:05:40.108838Z","caller":"traceutil/trace.go:171","msg":"trace[578629588] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"154.094358ms","start":"2026-04-21T17:05:39.954712Z","end":"2026-04-21T17:05:40.108806Z","steps":["trace[578629588] 'process raft request' (duration: 147.794885ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:05:40.110059Z","caller":"traceutil/trace.go:171","msg":"trace[1304858430] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"131.332879ms","start":"2026-04-21T17:05:39.978708Z","end":"2026-04-21T17:05:40.11004Z","steps":["trace[1304858430] 'process raft request' (duration: 131.296776ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:05:40.110301Z","caller":"traceutil/trace.go:171","msg":"trace[1545274188] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"139.657644ms","start":"2026-04-21T17:05:39.970636Z","end":"2026-04-21T17:05:40.110293Z","steps":["trace[1545274188] 'process raft request' (duration: 139.230982ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:05:40.110388Z","caller":"traceutil/trace.go:171","msg":"trace[266292642] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"139.633292ms","start":"2026-04-21T17:05:39.970749Z","end":"2026-04-21T17:05:40.110382Z","steps":["trace[266292642] 'process raft request' (duration: 139.185528ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:05:40.110465Z","caller":"traceutil/trace.go:171","msg":"trace[2024386977] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"139.458449ms","start":"2026-04-21T17:05:39.971001Z","end":"2026-04-21T17:05:40.110459Z","steps":["trace[2024386977] 'process raft request' (duration: 138.956191ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:05:40.110538Z","caller":"traceutil/trace.go:171","msg":"trace[302246744] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"139.015574ms","start":"2026-04-21T17:05:39.971515Z","end":"2026-04-21T17:05:40.110531Z","steps":["trace[302246744] 'process raft request' (duration: 138.465803ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:05:56.436399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.692055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-21T17:05:56.436498Z","caller":"traceutil/trace.go:171","msg":"trace[1742737758] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:746; }","duration":"169.842137ms","start":"2026-04-21T17:05:56.266632Z","end":"2026-04-21T17:05:56.436474Z","steps":["trace[1742737758] 'range keys from in-memory index tree' (duration: 169.520342ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:05:56.43651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.719667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-21T17:05:56.436592Z","caller":"traceutil/trace.go:171","msg":"trace[768187376] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:746; }","duration":"169.843657ms","start":"2026-04-21T17:05:56.266726Z","end":"2026-04-21T17:05:56.43657Z","steps":["trace[768187376] 'range keys from in-memory index tree' (duration: 169.553155ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:05:56.436652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.59976ms","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-04-21T17:05:56.436794Z","caller":"traceutil/trace.go:171","msg":"trace[961467608] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:746; }","duration":"171.815207ms","start":"2026-04-21T17:05:56.264948Z","end":"2026-04-21T17:05:56.436763Z","steps":["trace[961467608] 'range keys from in-memory index tree' (duration: 171.376902ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:05:56.43671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.447416ms","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-04-21T17:05:56.437183Z","caller":"traceutil/trace.go:171","msg":"trace[1928742711] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:746; }","duration":"167.972195ms","start":"2026-04-21T17:05:56.269164Z","end":"2026-04-21T17:05:56.437136Z","steps":["trace[1928742711] 'range keys from in-memory index tree' (duration: 167.198757ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:07:03.843425Z","caller":"traceutil/trace.go:171","msg":"trace[1256165123] transaction","detail":"{read_only:false; response_revision:1711; number_of_response:1; }","duration":"102.777262ms","start":"2026-04-21T17:07:03.740625Z","end":"2026-04-21T17:07:03.843402Z","steps":["trace[1256165123] 'process raft request' (duration: 102.641254ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:07:11.801024Z","caller":"traceutil/trace.go:171","msg":"trace[1109404409] transaction","detail":"{read_only:false; response_revision:1826; number_of_response:1; }","duration":"113.756211ms","start":"2026-04-21T17:07:11.687241Z","end":"2026-04-21T17:07:11.800997Z","steps":["trace[1109404409] 'process raft request' (duration: 113.242389ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:07:12.261867Z","caller":"traceutil/trace.go:171","msg":"trace[576234089] transaction","detail":"{read_only:false; response_revision:1828; number_of_response:1; }","duration":"124.741163ms","start":"2026-04-21T17:07:12.137082Z","end":"2026-04-21T17:07:12.261823Z","steps":["trace[576234089] 'process raft request' (duration: 124.117001ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:07:51.322204Z","caller":"traceutil/trace.go:171","msg":"trace[1370129114] linearizableReadLoop","detail":"{readStateIndex:2170; appliedIndex:2169; }","duration":"233.181673ms","start":"2026-04-21T17:07:51.088988Z","end":"2026-04-21T17:07:51.32217Z","steps":["trace[1370129114] 'read index received' (duration: 232.924351ms)","trace[1370129114] 'applied index is now lower than readState.Index' (duration: 256.122µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:07:51.322256Z","caller":"traceutil/trace.go:171","msg":"trace[1161034130] transaction","detail":"{read_only:false; response_revision:2091; number_of_response:1; }","duration":"237.555962ms","start":"2026-04-21T17:07:51.084661Z","end":"2026-04-21T17:07:51.322217Z","steps":["trace[1161034130] 'process raft request' (duration: 237.31632ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:07:51.322642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.645549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-21T17:07:51.322714Z","caller":"traceutil/trace.go:171","msg":"trace[1402006225] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2091; }","duration":"173.742889ms","start":"2026-04-21T17:07:51.148954Z","end":"2026-04-21T17:07:51.322696Z","steps":["trace[1402006225] 'agreement among raft nodes before linearized reading' (duration: 173.513148ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:07:51.322717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.191825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-21T17:07:51.322793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.721103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-04-21T17:07:51.322873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.879438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-21T17:07:51.322951Z","caller":"traceutil/trace.go:171","msg":"trace[1123822683] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2091; }","duration":"175.934194ms","start":"2026-04-21T17:07:51.146959Z","end":"2026-04-21T17:07:51.322893Z","steps":["trace[1123822683] 'agreement among raft nodes before linearized reading' (duration: 175.54225ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:07:51.322991Z","caller":"traceutil/trace.go:171","msg":"trace[126399355] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:2091; }","duration":"234.012138ms","start":"2026-04-21T17:07:51.08893Z","end":"2026-04-21T17:07:51.322943Z","steps":["trace[126399355] 'agreement among raft nodes before linearized reading' (duration: 233.423164ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:07:51.323078Z","caller":"traceutil/trace.go:171","msg":"trace[1146210424] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2091; }","duration":"173.419057ms","start":"2026-04-21T17:07:51.149468Z","end":"2026-04-21T17:07:51.322887Z","steps":["trace[1146210424] 'agreement among raft nodes before linearized reading' (duration: 172.920573ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:07:51.323176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.651439ms","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-04-21T17:07:51.323366Z","caller":"traceutil/trace.go:171","msg":"trace[601971320] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2091; }","duration":"182.88142ms","start":"2026-04-21T17:07:51.140465Z","end":"2026-04-21T17:07:51.323346Z","steps":["trace[601971320] 'agreement among raft nodes before linearized reading' (duration: 182.118515ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:07:51.323737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.539627ms","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-04-21T17:07:51.32387Z","caller":"traceutil/trace.go:171","msg":"trace[135923278] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2091; }","duration":"217.768058ms","start":"2026-04-21T17:07:51.106057Z","end":"2026-04-21T17:07:51.323826Z","steps":["trace[135923278] 'agreement among raft nodes before linearized reading' (duration: 216.315228ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:07:52.348763Z","caller":"traceutil/trace.go:171","msg":"trace[848105293] transaction","detail":"{read_only:false; response_revision:2097; number_of_response:1; }","duration":"150.041104ms","start":"2026-04-21T17:07:52.198691Z","end":"2026-04-21T17:07:52.348732Z","steps":["trace[848105293] 'process raft request' (duration: 149.871773ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:09:20.147961Z","caller":"traceutil/trace.go:171","msg":"trace[1226892410] transaction","detail":"{read_only:false; response_revision:2685; number_of_response:1; }","duration":"156.65533ms","start":"2026-04-21T17:09:19.991279Z","end":"2026-04-21T17:09:20.147934Z","steps":["trace[1226892410] 'process raft request' (duration: 147.428976ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:10:33.006429Z","caller":"traceutil/trace.go:171","msg":"trace[616491105] linearizableReadLoop","detail":"{readStateIndex:3179; appliedIndex:3178; }","duration":"432.011125ms","start":"2026-04-21T17:10:32.574394Z","end":"2026-04-21T17:10:33.006405Z","steps":["trace[616491105] 'read index received' (duration: 431.89709ms)","trace[616491105] 'applied index is now lower than readState.Index' (duration: 113.045µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:10:33.00649Z","caller":"traceutil/trace.go:171","msg":"trace[220242889] transaction","detail":"{read_only:false; response_revision:3064; number_of_response:1; }","duration":"462.612884ms","start":"2026-04-21T17:10:32.543844Z","end":"2026-04-21T17:10:33.006457Z","steps":["trace[220242889] 'process raft request' (duration: 462.426064ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:10:33.006584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.178733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:10:33.006618Z","caller":"traceutil/trace.go:171","msg":"trace[1093621176] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3064; }","duration":"432.255987ms","start":"2026-04-21T17:10:32.574352Z","end":"2026-04-21T17:10:33.006608Z","steps":["trace[1093621176] 'agreement among raft nodes before linearized reading' (duration: 432.188334ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:10:33.006656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:10:32.574334Z","time spent":"432.31479ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-21T17:10:33.007024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.305696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-21T17:10:33.007104Z","caller":"traceutil/trace.go:171","msg":"trace[1094914644] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:3064; }","duration":"130.449523ms","start":"2026-04-21T17:10:32.876636Z","end":"2026-04-21T17:10:33.007085Z","steps":["trace[1094914644] 'agreement among raft nodes before linearized reading' (duration: 129.96649ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:10:33.007173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:10:32.543831Z","time spent":"462.73557ms","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:10:33.571623Z","caller":"traceutil/trace.go:171","msg":"trace[2045563649] transaction","detail":"{read_only:false; response_revision:3065; number_of_response:1; }","duration":"414.751501ms","start":"2026-04-21T17:10:33.156848Z","end":"2026-04-21T17:10:33.571599Z","steps":["trace[2045563649] 'process raft request' (duration: 414.52532ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:10:33.571771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:10:33.156819Z","time spent":"414.894956ms","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:11:42.030766Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18082407362414584320,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T17:11:42.531562Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18082407362414584320,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T17:11:42.734145Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.358933099s","expected-duration":"1s"} {"level":"info","ts":"2026-04-21T17:11:42.734607Z","caller":"traceutil/trace.go:171","msg":"trace[971717667] transaction","detail":"{read_only:false; response_revision:3512; number_of_response:1; }","duration":"1.359450726s","start":"2026-04-21T17:11:41.375134Z","end":"2026-04-21T17:11:42.734584Z","steps":["trace[971717667] 'process raft request' (duration: 1.359202523s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:42.735055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:41.375116Z","time spent":"1.359542282s","remote":"127.0.0.1:34396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":796,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T17:11:43.617211Z","caller":"traceutil/trace.go:171","msg":"trace[350644343] transaction","detail":"{read_only:false; response_revision:3513; number_of_response:1; }","duration":"1.819527393s","start":"2026-04-21T17:11:41.79766Z","end":"2026-04-21T17:11:43.617188Z","steps":["trace[350644343] 'process raft request' (duration: 1.819352564s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:43.61736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:41.797647Z","time spent":"1.819636529s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:11:43.617712Z","caller":"traceutil/trace.go:171","msg":"trace[1531444527] transaction","detail":"{read_only:false; response_revision:3514; number_of_response:1; }","duration":"1.781410774s","start":"2026-04-21T17:11:41.836285Z","end":"2026-04-21T17:11:43.617696Z","steps":["trace[1531444527] 'process raft request' (duration: 1.780850944s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:43.617823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:41.83626Z","time spent":"1.78152162s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:11:43.617919Z","caller":"traceutil/trace.go:171","msg":"trace[5887381] transaction","detail":"{read_only:false; response_revision:3516; number_of_response:1; }","duration":"1.504032565s","start":"2026-04-21T17:11:42.113872Z","end":"2026-04-21T17:11:43.617905Z","steps":["trace[5887381] 'process raft request' (duration: 1.503901398s)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:43.617899Z","caller":"traceutil/trace.go:171","msg":"trace[700974314] transaction","detail":"{read_only:false; response_revision:3515; number_of_response:1; }","duration":"1.76206153s","start":"2026-04-21T17:11:41.855771Z","end":"2026-04-21T17:11:43.617833Z","steps":["trace[700974314] 'process raft request' (duration: 1.761784274s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:43.618006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:42.113846Z","time spent":"1.504123951s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:11:43.618007Z","caller":"traceutil/trace.go:171","msg":"trace[513148846] transaction","detail":"{read_only:false; response_revision:3517; number_of_response:1; }","duration":"1.482365924s","start":"2026-04-21T17:11:42.13563Z","end":"2026-04-21T17:11:43.617996Z","steps":["trace[513148846] 'process raft request' (duration: 1.482190033s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:43.618073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:42.135611Z","time spent":"1.482431728s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:11:43.618055Z","caller":"traceutil/trace.go:171","msg":"trace[1247336439] linearizableReadLoop","detail":"{readStateIndex:3649; appliedIndex:3643; }","duration":"2.087987223s","start":"2026-04-21T17:11:41.530053Z","end":"2026-04-21T17:11:43.61804Z","steps":["trace[1247336439] 'read index received' (duration: 1.20434412s)","trace[1247336439] 'applied index is now lower than readState.Index' (duration: 883.642093ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:11:43.618097Z","caller":"traceutil/trace.go:171","msg":"trace[1391559893] transaction","detail":"{read_only:false; response_revision:3518; number_of_response:1; }","duration":"999.119279ms","start":"2026-04-21T17:11:42.618968Z","end":"2026-04-21T17:11:43.618088Z","steps":["trace[1391559893] 'process raft request' (duration: 998.944759ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:43.618088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:41.85575Z","time spent":"1.762239129s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:11:43.618149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:42.618951Z","time spent":"999.172392ms","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:11:43.618278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"878.77801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-alertmanager-cookie-secret\" ","response":"range_response_count:1 size:811"} {"level":"info","ts":"2026-04-21T17:11:43.618316Z","caller":"traceutil/trace.go:171","msg":"trace[1259919332] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-alertmanager-cookie-secret; range_end:; response_count:1; response_revision:3518; }","duration":"878.838044ms","start":"2026-04-21T17:11:42.739469Z","end":"2026-04-21T17:11:43.618307Z","steps":["trace[1259919332] 'agreement among raft nodes before linearized reading' (duration: 878.74416ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:43.618297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.718262424s","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":"warn","ts":"2026-04-21T17:11:43.618357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.15613402s","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-04-21T17:11:43.618405Z","caller":"traceutil/trace.go:171","msg":"trace[330097543] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3518; }","duration":"1.156225275s","start":"2026-04-21T17:11:42.462169Z","end":"2026-04-21T17:11:43.618395Z","steps":["trace[330097543] 'agreement among raft nodes before linearized reading' (duration: 1.156099048s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:43.618424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"878.827583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-alertmanager-cookie-secret\" ","response":"range_response_count:1 size:811"} {"level":"warn","ts":"2026-04-21T17:11:43.61844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:42.462159Z","time spent":"1.156272058s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-21T17:11:43.618451Z","caller":"traceutil/trace.go:171","msg":"trace[1105810057] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-alertmanager-cookie-secret; range_end:; response_count:1; response_revision:3518; }","duration":"878.866625ms","start":"2026-04-21T17:11:42.739577Z","end":"2026-04-21T17:11:43.618444Z","steps":["trace[1105810057] 'agreement among raft nodes before linearized reading' (duration: 878.79741ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:43.618483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:42.739573Z","time spent":"878.903588ms","remote":"127.0.0.1:34396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":1,"response size":835,"request content":"key:\"/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-alertmanager-cookie-secret\" "} {"level":"warn","ts":"2026-04-21T17:11:43.618496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.042519405s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:11:43.618511Z","caller":"traceutil/trace.go:171","msg":"trace[1147811101] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3518; }","duration":"1.042578078s","start":"2026-04-21T17:11:42.575928Z","end":"2026-04-21T17:11:43.618506Z","steps":["trace[1147811101] 'agreement among raft nodes before linearized reading' (duration: 1.042554107s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:43.618528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:42.575906Z","time spent":"1.042618731s","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-21T17:11:43.618516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.158269666s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-21T17:11:43.618553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.161544293s","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-04-21T17:11:43.618587Z","caller":"traceutil/trace.go:171","msg":"trace[1694856974] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3518; }","duration":"1.15836225s","start":"2026-04-21T17:11:42.460206Z","end":"2026-04-21T17:11:43.618568Z","steps":["trace[1694856974] 'agreement among raft nodes before linearized reading' (duration: 1.158094566s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:43.618653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.156400305s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-21T17:11:43.618629Z","caller":"traceutil/trace.go:171","msg":"trace[2015873420] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3518; }","duration":"1.161659189s","start":"2026-04-21T17:11:42.456959Z","end":"2026-04-21T17:11:43.618619Z","steps":["trace[2015873420] 'agreement among raft nodes before linearized reading' (duration: 1.16148244s)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:43.61868Z","caller":"traceutil/trace.go:171","msg":"trace[621049678] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3518; }","duration":"1.156449419s","start":"2026-04-21T17:11:42.462225Z","end":"2026-04-21T17:11:43.618674Z","steps":["trace[621049678] 'agreement among raft nodes before linearized reading' (duration: 1.156388455s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:43.618549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.424752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:11:43.618706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:42.45694Z","time spent":"1.161755444s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-21T17:11:43.618752Z","caller":"traceutil/trace.go:171","msg":"trace[244078491] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:3518; }","duration":"587.858045ms","start":"2026-04-21T17:11:43.030848Z","end":"2026-04-21T17:11:43.618707Z","steps":["trace[244078491] 'agreement among raft nodes before linearized reading' (duration: 587.3984ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:11:43.618417Z","caller":"traceutil/trace.go:171","msg":"trace[887499986] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3518; }","duration":"1.718385762s","start":"2026-04-21T17:11:41.89999Z","end":"2026-04-21T17:11:43.618376Z","steps":["trace[887499986] 'agreement among raft nodes before linearized reading' (duration: 1.718214391s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:43.618808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:43.030827Z","time spent":"587.96613ms","remote":"127.0.0.1:50854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":29,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:11:43.618856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.088802747s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"warn","ts":"2026-04-21T17:11:43.618847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:41.899977Z","time spent":"1.718826655s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-21T17:11:43.618749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:42.462214Z","time spent":"1.156527782s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-21T17:11:43.618645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:42.460186Z","time spent":"1.158445976s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-21T17:11:43.618876Z","caller":"traceutil/trace.go:171","msg":"trace[1324301479] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3518; }","duration":"2.088855s","start":"2026-04-21T17:11:41.530015Z","end":"2026-04-21T17:11:43.61887Z","steps":["trace[1324301479] 'agreement among raft nodes before linearized reading' (duration: 2.088131641s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:11:43.618954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:41.529996Z","time spent":"2.088952835s","remote":"127.0.0.1:50908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-21T17:11:43.618358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:11:42.739451Z","time spent":"878.899027ms","remote":"127.0.0.1:34396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":1,"response size":835,"request content":"key:\"/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-alertmanager-cookie-secret\" "} {"level":"info","ts":"2026-04-21T17:11:43.791528Z","caller":"traceutil/trace.go:171","msg":"trace[1759069991] transaction","detail":"{read_only:false; response_revision:3524; number_of_response:1; }","duration":"125.869516ms","start":"2026-04-21T17:11:43.665632Z","end":"2026-04-21T17:11:43.791501Z","steps":["trace[1759069991] 'process raft request' (duration: 113.127607ms)","trace[1759069991] 'compare' (duration: 12.599002ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:12:10.184677Z","caller":"traceutil/trace.go:171","msg":"trace[1597108263] transaction","detail":"{read_only:false; response_revision:3717; number_of_response:1; }","duration":"504.432651ms","start":"2026-04-21T17:12:09.68021Z","end":"2026-04-21T17:12:10.184642Z","steps":["trace[1597108263] 'process raft request' (duration: 498.492339ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:10.185075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:09.680195Z","time spent":"504.661703ms","remote":"127.0.0.1:50758","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6131,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:12:10.185971Z","caller":"traceutil/trace.go:171","msg":"trace[919161453] transaction","detail":"{read_only:false; response_revision:3718; number_of_response:1; }","duration":"474.035532ms","start":"2026-04-21T17:12:09.71192Z","end":"2026-04-21T17:12:10.185956Z","steps":["trace[919161453] 'process raft request' (duration: 472.635984ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:10.186062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:09.711905Z","time spent":"474.108277ms","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:12:10.186598Z","caller":"traceutil/trace.go:171","msg":"trace[43314452] transaction","detail":"{read_only:false; response_revision:3719; number_of_response:1; }","duration":"464.601276ms","start":"2026-04-21T17:12:09.721982Z","end":"2026-04-21T17:12:10.186583Z","steps":["trace[43314452] 'process raft request' (duration: 463.882345ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:10.186825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:09.721972Z","time spent":"464.667771ms","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:12:10.18761Z","caller":"traceutil/trace.go:171","msg":"trace[1317327637] transaction","detail":"{read_only:false; response_revision:3720; number_of_response:1; }","duration":"465.560879ms","start":"2026-04-21T17:12:09.722033Z","end":"2026-04-21T17:12:10.187594Z","steps":["trace[1317327637] 'process raft request' (duration: 463.885246ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:10.187695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:09.72203Z","time spent":"465.622923ms","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:12:10.188274Z","caller":"traceutil/trace.go:171","msg":"trace[1873566867] transaction","detail":"{read_only:false; response_revision:3721; number_of_response:1; }","duration":"466.196815ms","start":"2026-04-21T17:12:09.722062Z","end":"2026-04-21T17:12:10.188259Z","steps":["trace[1873566867] 'process raft request' (duration: 465.38051ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:10.188353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:09.722059Z","time spent":"466.254678ms","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:12:10.189299Z","caller":"traceutil/trace.go:171","msg":"trace[1864646546] linearizableReadLoop","detail":"{readStateIndex:3863; appliedIndex:3858; }","duration":"426.832447ms","start":"2026-04-21T17:12:09.762447Z","end":"2026-04-21T17:12:10.189279Z","steps":["trace[1864646546] 'read index received' (duration: 416.299378ms)","trace[1864646546] 'applied index is now lower than readState.Index' (duration: 10.531909ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:12:10.189683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.215729ms","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-04-21T17:12:10.189676Z","caller":"traceutil/trace.go:171","msg":"trace[1391951075] transaction","detail":"{read_only:false; response_revision:3722; number_of_response:1; }","duration":"387.702463ms","start":"2026-04-21T17:12:09.80194Z","end":"2026-04-21T17:12:10.189642Z","steps":["trace[1391951075] 'process raft request' (duration: 387.049796ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:12:10.189767Z","caller":"traceutil/trace.go:171","msg":"trace[2071253609] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3722; }","duration":"427.347137ms","start":"2026-04-21T17:12:09.762389Z","end":"2026-04-21T17:12:10.189736Z","steps":["trace[2071253609] 'agreement among raft nodes before linearized reading' (duration: 427.144075ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:10.189765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.848522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-21T17:12:10.189795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:09.762361Z","time spent":"427.429501ms","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-21T17:12:10.189855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.204668ms","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-04-21T17:12:10.18991Z","caller":"traceutil/trace.go:171","msg":"trace[1763548634] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3722; }","duration":"423.931975ms","start":"2026-04-21T17:12:09.765868Z","end":"2026-04-21T17:12:10.1898Z","steps":["trace[1763548634] 'agreement among raft nodes before linearized reading' (duration: 423.729044ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:12:10.189943Z","caller":"traceutil/trace.go:171","msg":"trace[108907206] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3722; }","duration":"408.314853ms","start":"2026-04-21T17:12:09.781609Z","end":"2026-04-21T17:12:10.189923Z","steps":["trace[108907206] 'agreement among raft nodes before linearized reading' (duration: 408.031878ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:10.18996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:09.765862Z","time spent":"424.086084ms","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-21T17:12:10.189995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:09.781603Z","time spent":"408.383037ms","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-21T17:12:10.190029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.676881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-21T17:12:10.190049Z","caller":"traceutil/trace.go:171","msg":"trace[753713403] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3722; }","duration":"416.733583ms","start":"2026-04-21T17:12:09.77331Z","end":"2026-04-21T17:12:10.190043Z","steps":["trace[753713403] 'agreement among raft nodes before linearized reading' (duration: 416.67908ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:10.190038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.634867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-04-21T17:12:10.190064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:09.773281Z","time spent":"416.779406ms","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-21T17:12:10.190078Z","caller":"traceutil/trace.go:171","msg":"trace[487350492] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3722; }","duration":"416.705472ms","start":"2026-04-21T17:12:09.773361Z","end":"2026-04-21T17:12:10.190066Z","steps":["trace[487350492] 'agreement among raft nodes before linearized reading' (duration: 416.565293ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:10.189878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:09.801927Z","time spent":"387.84993ms","remote":"127.0.0.1:50758","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":269833,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:12:10.190115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:09.773358Z","time spent":"416.749025ms","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-21T17:12:10.190192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.064626ms","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-04-21T17:12:10.190338Z","caller":"traceutil/trace.go:171","msg":"trace[520258031] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:3722; }","duration":"180.274028ms","start":"2026-04-21T17:12:10.010048Z","end":"2026-04-21T17:12:10.190322Z","steps":["trace[520258031] 'agreement among raft nodes before linearized reading' (duration: 180.052435ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:12:15.663031Z","caller":"traceutil/trace.go:171","msg":"trace[1001238726] transaction","detail":"{read_only:false; response_revision:3756; number_of_response:1; }","duration":"276.55693ms","start":"2026-04-21T17:12:15.386433Z","end":"2026-04-21T17:12:15.66299Z","steps":["trace[1001238726] 'process raft request' (duration: 276.352688ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:16.718182Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18082407362414584942,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T17:12:17.219134Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18082407362414584942,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T17:12:17.719474Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18082407362414584942,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T17:12:17.76048Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.554024035s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-21T17:12:18.059314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.234404ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T17:12:18.059838Z","caller":"traceutil/trace.go:171","msg":"trace[603611703] transaction","detail":"{read_only:false; response_revision:3757; number_of_response:1; }","duration":"1.853474567s","start":"2026-04-21T17:12:16.206337Z","end":"2026-04-21T17:12:18.059811Z","steps":["trace[603611703] 'process raft request' (duration: 1.554430158s)","trace[603611703] 'compare' (duration: 296.594381ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:12:18.059999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:16.20631Z","time spent":"1.853599385s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:12:18.060422Z","caller":"traceutil/trace.go:171","msg":"trace[1292827698] linearizableReadLoop","detail":"{readStateIndex:3905; appliedIndex:3900; }","duration":"1.843332408s","start":"2026-04-21T17:12:16.21707Z","end":"2026-04-21T17:12:18.060403Z","steps":["trace[1292827698] 'read index received' (duration: 1.543708255s)","trace[1292827698] 'applied index is now lower than readState.Index' (duration: 299.622893ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:12:18.060776Z","caller":"traceutil/trace.go:171","msg":"trace[1601514650] transaction","detail":"{read_only:false; response_revision:3761; number_of_response:1; }","duration":"1.778764825s","start":"2026-04-21T17:12:16.281995Z","end":"2026-04-21T17:12:18.06076Z","steps":["trace[1601514650] 'process raft request' (duration: 1.778366243s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:18.060838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:16.28198Z","time spent":"1.778830969s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:12:18.060955Z","caller":"traceutil/trace.go:171","msg":"trace[1394146735] transaction","detail":"{read_only:false; response_revision:3758; number_of_response:1; }","duration":"1.849986872s","start":"2026-04-21T17:12:16.21096Z","end":"2026-04-21T17:12:18.060947Z","steps":["trace[1394146735] 'process raft request' (duration: 1.849218937s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:18.061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:16.210938Z","time spent":"1.850040625s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:12:18.061086Z","caller":"traceutil/trace.go:171","msg":"trace[876137923] transaction","detail":"{read_only:false; response_revision:3759; number_of_response:1; }","duration":"1.848508519s","start":"2026-04-21T17:12:16.21257Z","end":"2026-04-21T17:12:18.061079Z","steps":["trace[876137923] 'process raft request' (duration: 1.847710684s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:18.061128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:16.212545Z","time spent":"1.848563841s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:12:18.061159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.84409561s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-21T17:12:18.06121Z","caller":"traceutil/trace.go:171","msg":"trace[631235942] transaction","detail":"{read_only:false; response_revision:3760; number_of_response:1; }","duration":"1.84657962s","start":"2026-04-21T17:12:16.214624Z","end":"2026-04-21T17:12:18.061203Z","steps":["trace[631235942] 'process raft request' (duration: 1.84570529s)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:12:18.061212Z","caller":"traceutil/trace.go:171","msg":"trace[1839985983] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3761; }","duration":"1.844166364s","start":"2026-04-21T17:12:16.217028Z","end":"2026-04-21T17:12:18.061194Z","steps":["trace[1839985983] 'agreement among raft nodes before linearized reading' (duration: 1.844075259s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:18.061278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:16.217016Z","time spent":"1.844253829s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-21T17:12:18.061453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.832983556s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-21T17:12:18.061486Z","caller":"traceutil/trace.go:171","msg":"trace[1608367814] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:3761; }","duration":"1.833038838s","start":"2026-04-21T17:12:16.22844Z","end":"2026-04-21T17:12:18.061479Z","steps":["trace[1608367814] 'agreement among raft nodes before linearized reading' (duration: 1.832949253s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:18.061513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:16.22843Z","time spent":"1.833077212s","remote":"127.0.0.1:50928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":62,"response size":31,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:12:18.061523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.835806634s","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-04-21T17:12:18.06156Z","caller":"traceutil/trace.go:171","msg":"trace[1860916445] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3761; }","duration":"1.835870147s","start":"2026-04-21T17:12:16.22568Z","end":"2026-04-21T17:12:18.06155Z","steps":["trace[1860916445] 'agreement among raft nodes before linearized reading' (duration: 1.835777092s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:18.061595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:16.225676Z","time spent":"1.835913021s","remote":"127.0.0.1:51002","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-04-21T17:12:18.061635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.905997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:12:18.061663Z","caller":"traceutil/trace.go:171","msg":"trace[217788051] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:3761; }","duration":"448.96883ms","start":"2026-04-21T17:12:17.612686Z","end":"2026-04-21T17:12:18.061655Z","steps":["trace[217788051] 'agreement among raft nodes before linearized reading' (duration: 448.924767ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:18.061691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:17.612667Z","time spent":"449.016014ms","remote":"127.0.0.1:38088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:12:18.061788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.836558556s","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-04-21T17:12:18.061824Z","caller":"traceutil/trace.go:171","msg":"trace[1040208641] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3761; }","duration":"1.83661521s","start":"2026-04-21T17:12:16.2252Z","end":"2026-04-21T17:12:18.061816Z","steps":["trace[1040208641] 'agreement among raft nodes before linearized reading' (duration: 1.836497143s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:18.061776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.549707623s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-21T17:12:18.061929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.841558409s","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-04-21T17:12:18.061964Z","caller":"traceutil/trace.go:171","msg":"trace[2033589826] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3761; }","duration":"1.84160818s","start":"2026-04-21T17:12:16.220348Z","end":"2026-04-21T17:12:18.061956Z","steps":["trace[2033589826] 'agreement among raft nodes before linearized reading' (duration: 1.841530185s)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:12:18.061917Z","caller":"traceutil/trace.go:171","msg":"trace[1466168879] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:3761; }","duration":"1.549939116s","start":"2026-04-21T17:12:16.511964Z","end":"2026-04-21T17:12:18.061903Z","steps":["trace[1466168879] 'agreement among raft nodes before linearized reading' (duration: 1.549723364s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:18.062002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:16.220342Z","time spent":"1.841651193s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-21T17:12:18.061246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:16.214603Z","time spent":"1.846624533s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:12:18.061058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.842866432s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-21T17:12:18.06207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:16.511951Z","time spent":"1.550090964s","remote":"127.0.0.1:51168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":31,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-04-21T17:12:18.062094Z","caller":"traceutil/trace.go:171","msg":"trace[242052771] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3761; }","duration":"1.843958893s","start":"2026-04-21T17:12:16.218127Z","end":"2026-04-21T17:12:18.062085Z","steps":["trace[242052771] 'agreement among raft nodes before linearized reading' (duration: 1.842771566s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:18.062121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:16.218117Z","time spent":"1.843996955s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-21T17:12:18.061883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.644390008s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-04-21T17:12:18.062204Z","caller":"traceutil/trace.go:171","msg":"trace[1289632375] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:3761; }","duration":"1.644745689s","start":"2026-04-21T17:12:16.417452Z","end":"2026-04-21T17:12:18.062198Z","steps":["trace[1289632375] 'agreement among raft nodes before linearized reading' (duration: 1.644345596s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:18.062226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:16.417433Z","time spent":"1.64478461s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":553,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"warn","ts":"2026-04-21T17:12:18.061862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:16.225196Z","time spent":"1.836660352s","remote":"127.0.0.1:51002","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-04-21T17:12:18.062393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.485851652s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:12:18.062559Z","caller":"traceutil/trace.go:171","msg":"trace[1148454068] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3761; }","duration":"1.485952378s","start":"2026-04-21T17:12:16.576528Z","end":"2026-04-21T17:12:18.06248Z","steps":["trace[1148454068] 'agreement among raft nodes before linearized reading' (duration: 1.485846811s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:18.062609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:16.576523Z","time spent":"1.486074714s","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-21T17:12:19.076642Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.002369972s","expected-duration":"1s"} {"level":"info","ts":"2026-04-21T17:12:19.077798Z","caller":"traceutil/trace.go:171","msg":"trace[1347061653] transaction","detail":"{read_only:false; response_revision:3763; number_of_response:1; }","duration":"1.010550922s","start":"2026-04-21T17:12:18.06722Z","end":"2026-04-21T17:12:19.077771Z","steps":["trace[1347061653] 'process raft request' (duration: 1.00961977s)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:12:19.077853Z","caller":"traceutil/trace.go:171","msg":"trace[1155839834] transaction","detail":"{read_only:false; response_revision:3765; number_of_response:1; }","duration":"1.010002861s","start":"2026-04-21T17:12:18.067823Z","end":"2026-04-21T17:12:19.077825Z","steps":["trace[1155839834] 'process raft request' (duration: 1.009892724s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:19.077928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:18.067207Z","time spent":"1.010638946s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:12:19.077986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:18.067816Z","time spent":"1.010096427s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:12:19.07813Z","caller":"traceutil/trace.go:171","msg":"trace[1110361458] transaction","detail":"{read_only:false; response_revision:3764; number_of_response:1; }","duration":"1.010845498s","start":"2026-04-21T17:12:18.067274Z","end":"2026-04-21T17:12:19.07812Z","steps":["trace[1110361458] 'process raft request' (duration: 1.01035197s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:19.078177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:18.067257Z","time spent":"1.010893561s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:12:19.078186Z","caller":"traceutil/trace.go:171","msg":"trace[680050363] transaction","detail":"{read_only:false; response_revision:3766; number_of_response:1; }","duration":"1.010220504s","start":"2026-04-21T17:12:18.067936Z","end":"2026-04-21T17:12:19.078156Z","steps":["trace[680050363] 'process raft request' (duration: 1.009852093s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:19.078382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:18.067912Z","time spent":"1.01035587s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:12:19.07882Z","caller":"traceutil/trace.go:171","msg":"trace[595764106] linearizableReadLoop","detail":"{readStateIndex:3911; appliedIndex:3906; }","duration":"1.008420242s","start":"2026-04-21T17:12:18.070385Z","end":"2026-04-21T17:12:19.078805Z","steps":["trace[595764106] 'read index received' (duration: 4.164294ms)","trace[595764106] 'applied index is now lower than readState.Index' (duration: 1.004254478s)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:12:19.079134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.008256902s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-04-21T17:12:19.079185Z","caller":"traceutil/trace.go:171","msg":"trace[73495095] transaction","detail":"{read_only:false; response_revision:3767; number_of_response:1; }","duration":"1.010060554s","start":"2026-04-21T17:12:18.06911Z","end":"2026-04-21T17:12:19.07917Z","steps":["trace[73495095] 'process raft request' (duration: 1.008933251s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:19.079223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.855647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:12:19.079238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"990.863763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/kube-prometheus-stack-dashboard-node-exporter-full\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:12:19.079259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:18.069101Z","time spent":"1.010118038s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:12:19.079267Z","caller":"traceutil/trace.go:171","msg":"trace[2064762645] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:3767; }","duration":"111.996785ms","start":"2026-04-21T17:12:18.967258Z","end":"2026-04-21T17:12:19.079254Z","steps":["trace[2064762645] 'agreement among raft nodes before linearized reading' (duration: 111.917501ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:12:19.079269Z","caller":"traceutil/trace.go:171","msg":"trace[1682714750] range","detail":"{range_begin:/registry/configmaps/monitoring/kube-prometheus-stack-dashboard-node-exporter-full; range_end:; response_count:0; response_revision:3767; }","duration":"990.899705ms","start":"2026-04-21T17:12:18.08836Z","end":"2026-04-21T17:12:19.07926Z","steps":["trace[1682714750] 'agreement among raft nodes before linearized reading' (duration: 990.853431ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:19.079305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:18.088354Z","time spent":"990.944496ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":29,"request content":"key:\"/registry/configmaps/monitoring/kube-prometheus-stack-dashboard-node-exporter-full\" "} {"level":"info","ts":"2026-04-21T17:12:19.079192Z","caller":"traceutil/trace.go:171","msg":"trace[962193205] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:3767; }","duration":"1.008320747s","start":"2026-04-21T17:12:18.070853Z","end":"2026-04-21T17:12:19.079174Z","steps":["trace[962193205] 'agreement among raft nodes before linearized reading' (duration: 1.008138166s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:19.079408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:18.070849Z","time spent":"1.008549579s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":582,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-04-21T17:12:19.079458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.009054478s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:12:19.079538Z","caller":"traceutil/trace.go:171","msg":"trace[2122880699] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3767; }","duration":"1.009165844s","start":"2026-04-21T17:12:18.070352Z","end":"2026-04-21T17:12:19.079517Z","steps":["trace[2122880699] 'agreement among raft nodes before linearized reading' (duration: 1.009059698s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:19.079579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:18.070343Z","time spent":"1.009229367s","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-21T17:12:19.768787Z","caller":"traceutil/trace.go:171","msg":"trace[1267831739] linearizableReadLoop","detail":"{readStateIndex:3913; appliedIndex:3912; }","duration":"442.566154ms","start":"2026-04-21T17:12:19.326199Z","end":"2026-04-21T17:12:19.768765Z","steps":["trace[1267831739] 'read index received' (duration: 441.900837ms)","trace[1267831739] 'applied index is now lower than readState.Index' (duration: 664.037µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:12:19.768989Z","caller":"traceutil/trace.go:171","msg":"trace[412312354] transaction","detail":"{read_only:false; response_revision:3769; number_of_response:1; }","duration":"656.062297ms","start":"2026-04-21T17:12:19.112896Z","end":"2026-04-21T17:12:19.768959Z","steps":["trace[412312354] 'process raft request' (duration: 655.600501ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:19.769106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:19.112606Z","time spent":"656.427178ms","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":683747,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T17:12:19.76936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.163788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-04-21T17:12:19.769411Z","caller":"traceutil/trace.go:171","msg":"trace[772625149] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3769; }","duration":"443.256384ms","start":"2026-04-21T17:12:19.326147Z","end":"2026-04-21T17:12:19.769403Z","steps":["trace[772625149] 'agreement among raft nodes before linearized reading' (duration: 443.092224ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:19.769448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:19.326129Z","time spent":"443.312336ms","remote":"127.0.0.1:50908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-21T17:12:19.769651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.570134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:12:19.769774Z","caller":"traceutil/trace.go:171","msg":"trace[365063553] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:3769; }","duration":"239.732391ms","start":"2026-04-21T17:12:19.529998Z","end":"2026-04-21T17:12:19.769731Z","steps":["trace[365063553] 'agreement among raft nodes before linearized reading' (duration: 239.577273ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:19.769946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.40895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-21T17:12:19.770025Z","caller":"traceutil/trace.go:171","msg":"trace[756287982] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:3769; }","duration":"129.562908ms","start":"2026-04-21T17:12:19.640444Z","end":"2026-04-21T17:12:19.770007Z","steps":["trace[756287982] 'agreement among raft nodes before linearized reading' (duration: 129.392738ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:20.57824Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18082407362414584971,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T17:12:21.078452Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18082407362414584971,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T17:12:21.579625Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18082407362414584971,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T17:12:21.894067Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.827855276s","expected-duration":"1s"} {"level":"info","ts":"2026-04-21T17:12:21.894546Z","caller":"traceutil/trace.go:171","msg":"trace[1252441988] transaction","detail":"{read_only:false; response_revision:3770; number_of_response:1; }","duration":"1.828407007s","start":"2026-04-21T17:12:20.066115Z","end":"2026-04-21T17:12:21.894522Z","steps":["trace[1252441988] 'process raft request' (duration: 1.828266469s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:21.894701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:20.066087Z","time spent":"1.828531074s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:12:22.577806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000158862s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-21T17:12:22.577921Z","caller":"traceutil/trace.go:171","msg":"trace[510675625] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000293329s","start":"2026-04-21T17:12:20.577604Z","end":"2026-04-21T17:12:22.577898Z","steps":["trace[510675625] 'agreement among raft nodes before linearized reading' (duration: 2.0001312s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:22.577985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:20.577533Z","time spent":"2.000441028s","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/21 17:12:22 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-21T17:12:22.965593Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.069651344s","expected-duration":"1s"} {"level":"info","ts":"2026-04-21T17:12:22.97064Z","caller":"traceutil/trace.go:171","msg":"trace[1730371293] transaction","detail":"{read_only:false; response_revision:3772; number_of_response:1; }","duration":"2.902234196s","start":"2026-04-21T17:12:20.06837Z","end":"2026-04-21T17:12:22.970604Z","steps":["trace[1730371293] 'process raft request' (duration: 2.901110833s)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:12:22.970589Z","caller":"traceutil/trace.go:171","msg":"trace[1349371383] transaction","detail":"{read_only:false; response_revision:3771; number_of_response:1; }","duration":"2.902302971s","start":"2026-04-21T17:12:20.06824Z","end":"2026-04-21T17:12:22.970543Z","steps":["trace[1349371383] 'process raft request' (duration: 2.897706711s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:22.970961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:20.068343Z","time spent":"2.902527202s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:12:22.971108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:20.068223Z","time spent":"2.902778706s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:12:22.970723Z","caller":"traceutil/trace.go:171","msg":"trace[137249980] transaction","detail":"{read_only:false; response_revision:3773; number_of_response:1; }","duration":"2.901641133s","start":"2026-04-21T17:12:20.069038Z","end":"2026-04-21T17:12:22.970679Z","steps":["trace[137249980] 'process raft request' (duration: 2.900573023s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:22.971308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:20.069029Z","time spent":"2.902169723s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T17:12:23.000884Z","caller":"traceutil/trace.go:171","msg":"trace[572667971] linearizableReadLoop","detail":"{readStateIndex:3919; appliedIndex:3914; }","duration":"2.922900497s","start":"2026-04-21T17:12:20.077966Z","end":"2026-04-21T17:12:23.000867Z","steps":["trace[572667971] 'read index received' (duration: 1.816568739s)","trace[572667971] 'applied index is now lower than readState.Index' (duration: 1.106330708s)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:12:23.000981Z","caller":"traceutil/trace.go:171","msg":"trace[2030605696] transaction","detail":"{read_only:false; response_revision:3774; number_of_response:1; }","duration":"1.847219032s","start":"2026-04-21T17:12:21.153695Z","end":"2026-04-21T17:12:23.000914Z","steps":["trace[2030605696] 'process raft request' (duration: 1.847042101s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:23.001108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.921805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:12:23.001145Z","caller":"traceutil/trace.go:171","msg":"trace[1843311966] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3774; }","duration":"233.00555ms","start":"2026-04-21T17:12:22.768128Z","end":"2026-04-21T17:12:23.001134Z","steps":["trace[1843311966] 'agreement among raft nodes before linearized reading' (duration: 232.959148ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:23.001149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.917266192s","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-04-21T17:12:23.001272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:21.153649Z","time spent":"1.847473396s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T17:12:23.001338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.918588707s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-21T17:12:23.00106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.861664538s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:12:23.001259Z","caller":"traceutil/trace.go:171","msg":"trace[2053419976] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3774; }","duration":"1.917389238s","start":"2026-04-21T17:12:21.08386Z","end":"2026-04-21T17:12:23.001249Z","steps":["trace[2053419976] 'agreement among raft nodes before linearized reading' (duration: 1.91724218s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:23.00145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.418311797s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/kube-prometheus-stack-dashboard-ceph-cluster\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:12:23.001483Z","caller":"traceutil/trace.go:171","msg":"trace[999951974] range","detail":"{range_begin:/registry/configmaps/monitoring/kube-prometheus-stack-dashboard-ceph-cluster; range_end:; response_count:0; response_revision:3774; }","duration":"2.41837126s","start":"2026-04-21T17:12:20.583101Z","end":"2026-04-21T17:12:23.001472Z","steps":["trace[999951974] 'agreement among raft nodes before linearized reading' (duration: 2.418329097s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:23.00149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.917647814s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-21T17:12:23.001513Z","caller":"traceutil/trace.go:171","msg":"trace[1844806982] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3774; }","duration":"1.917691525s","start":"2026-04-21T17:12:21.083815Z","end":"2026-04-21T17:12:23.001507Z","steps":["trace[1844806982] 'agreement among raft nodes before linearized reading' (duration: 1.917616901s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:23.00155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:21.083805Z","time spent":"1.917738929s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-21T17:12:23.001462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:21.083849Z","time spent":"1.91760388s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-21T17:12:23.00181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.753439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-21T17:12:23.001844Z","caller":"traceutil/trace.go:171","msg":"trace[184780425] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:3774; }","duration":"540.824534ms","start":"2026-04-21T17:12:22.461009Z","end":"2026-04-21T17:12:23.001834Z","steps":["trace[184780425] 'agreement among raft nodes before linearized reading' (duration: 540.76249ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:23.001841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.918159333s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-21T17:12:23.001875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:22.460962Z","time spent":"540.907888ms","remote":"127.0.0.1:51202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":6,"response size":31,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "} {"level":"info","ts":"2026-04-21T17:12:23.001882Z","caller":"traceutil/trace.go:171","msg":"trace[1213639521] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3774; }","duration":"1.918266038s","start":"2026-04-21T17:12:21.08361Z","end":"2026-04-21T17:12:23.001876Z","steps":["trace[1213639521] 'agreement among raft nodes before linearized reading' (duration: 1.918025855s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:23.001908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:21.08359Z","time spent":"1.918312242s","remote":"127.0.0.1:51002","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-04-21T17:12:23.001359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.921853552s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:12:23.002897Z","caller":"traceutil/trace.go:171","msg":"trace[1815449042] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:3774; }","duration":"1.923393958s","start":"2026-04-21T17:12:21.079495Z","end":"2026-04-21T17:12:23.002889Z","steps":["trace[1815449042] 'agreement among raft nodes before linearized reading' (duration: 1.92183347s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:23.002927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:21.079463Z","time spent":"1.923450602s","remote":"127.0.0.1:38012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:12:23.001511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:20.583084Z","time spent":"2.418421463s","remote":"127.0.0.1:50822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":29,"request content":"key:\"/registry/configmaps/monitoring/kube-prometheus-stack-dashboard-ceph-cluster\" "} {"level":"info","ts":"2026-04-21T17:12:23.001517Z","caller":"traceutil/trace.go:171","msg":"trace[255738093] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:3774; }","duration":"2.862104624s","start":"2026-04-21T17:12:20.139331Z","end":"2026-04-21T17:12:23.001436Z","steps":["trace[255738093] 'agreement among raft nodes before linearized reading' (duration: 2.86167124s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:23.003099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:20.139319Z","time spent":"2.863772038s","remote":"127.0.0.1:57118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-04-21T17:12:23.001406Z","caller":"traceutil/trace.go:171","msg":"trace[1501938205] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3774; }","duration":"1.918700753s","start":"2026-04-21T17:12:21.082689Z","end":"2026-04-21T17:12:23.00139Z","steps":["trace[1501938205] 'agreement among raft nodes before linearized reading' (duration: 1.918455849s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:23.003208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:21.082678Z","time spent":"1.920492195s","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-21T17:12:23.001407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.173837092s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-21T17:12:23.003317Z","caller":"traceutil/trace.go:171","msg":"trace[1975908827] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:3774; }","duration":"2.175778833s","start":"2026-04-21T17:12:20.827518Z","end":"2026-04-21T17:12:23.003296Z","steps":["trace[1975908827] 'agreement among raft nodes before linearized reading' (duration: 2.173863445s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:23.001073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.923110458s","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-04-21T17:12:23.003391Z","caller":"traceutil/trace.go:171","msg":"trace[793663507] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3774; }","duration":"2.925459581s","start":"2026-04-21T17:12:20.077915Z","end":"2026-04-21T17:12:23.003374Z","steps":["trace[793663507] 'agreement among raft nodes before linearized reading' (duration: 2.923062216s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:23.003393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:20.827493Z","time spent":"2.175875028s","remote":"127.0.0.1:51124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":31,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:12:23.003423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:20.077898Z","time spent":"2.925515144s","remote":"127.0.0.1:51002","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-04-21T17:12:23.001688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.499583134s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-21T17:12:23.003525Z","caller":"traceutil/trace.go:171","msg":"trace[1139789306] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:3774; }","duration":"1.501461149s","start":"2026-04-21T17:12:21.502055Z","end":"2026-04-21T17:12:23.003517Z","steps":["trace[1139789306] 'agreement among raft nodes before linearized reading' (duration: 1.499596864s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:23.001708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.300805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T17:12:23.003608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:21.502035Z","time spent":"1.501558766s","remote":"127.0.0.1:51200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":14,"response size":31,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"info","ts":"2026-04-21T17:12:23.003628Z","caller":"traceutil/trace.go:171","msg":"trace[1958130905] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3774; }","duration":"425.270477ms","start":"2026-04-21T17:12:22.578338Z","end":"2026-04-21T17:12:23.003609Z","steps":["trace[1958130905] 'agreement among raft nodes before linearized reading' (duration: 423.311356ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:23.003734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:22.578315Z","time spent":"425.411565ms","remote":"127.0.0.1:50710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-21T17:12:23.001768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.891188837s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:12:23.003834Z","caller":"traceutil/trace.go:171","msg":"trace[1022216367] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:3774; }","duration":"1.893304657s","start":"2026-04-21T17:12:21.11052Z","end":"2026-04-21T17:12:23.003825Z","steps":["trace[1022216367] 'agreement among raft nodes before linearized reading' (duration: 1.891196918s)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:23.003857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:21.110501Z","time spent":"1.89335082s","remote":"127.0.0.1:57356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"warn","ts":"2026-04-21T17:12:23.001722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.548158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:12:23.003936Z","caller":"traceutil/trace.go:171","msg":"trace[895654334] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:3774; }","duration":"574.763783ms","start":"2026-04-21T17:12:22.429155Z","end":"2026-04-21T17:12:23.003918Z","steps":["trace[895654334] 'agreement among raft nodes before linearized reading' (duration: 572.490655ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:12:23.003974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:12:22.429075Z","time spent":"574.88477ms","remote":"127.0.0.1:57152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-04-21T17:13:11.028152Z","caller":"traceutil/trace.go:171","msg":"trace[2010243731] transaction","detail":"{read_only:false; response_revision:4630; number_of_response:1; }","duration":"196.706575ms","start":"2026-04-21T17:13:10.831388Z","end":"2026-04-21T17:13:11.028095Z","steps":["trace[2010243731] 'process raft request' (duration: 196.44494ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:11.028289Z","caller":"traceutil/trace.go:171","msg":"trace[396938934] linearizableReadLoop","detail":"{readStateIndex:4805; appliedIndex:4804; }","duration":"145.721961ms","start":"2026-04-21T17:13:10.882273Z","end":"2026-04-21T17:13:11.027995Z","steps":["trace[396938934] 'read index received' (duration: 145.418974ms)","trace[396938934] 'applied index is now lower than readState.Index' (duration: 302.277µs)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:11.028645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.35149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-21T17:13:11.02869Z","caller":"traceutil/trace.go:171","msg":"trace[1678584745] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:4630; }","duration":"146.490717ms","start":"2026-04-21T17:13:10.882187Z","end":"2026-04-21T17:13:11.028678Z","steps":["trace[1678584745] 'agreement among raft nodes before linearized reading' (duration: 146.283975ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:11.236738Z","caller":"traceutil/trace.go:171","msg":"trace[1984288757] linearizableReadLoop","detail":"{readStateIndex:4806; appliedIndex:4805; }","duration":"203.193242ms","start":"2026-04-21T17:13:11.033502Z","end":"2026-04-21T17:13:11.236695Z","steps":["trace[1984288757] 'read index received' (duration: 153.948621ms)","trace[1984288757] 'applied index is now lower than readState.Index' (duration: 49.243061ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:13:11.236876Z","caller":"traceutil/trace.go:171","msg":"trace[321412547] transaction","detail":"{read_only:false; response_revision:4631; number_of_response:1; }","duration":"205.797845ms","start":"2026-04-21T17:13:11.031037Z","end":"2026-04-21T17:13:11.236835Z","steps":["trace[321412547] 'process raft request' (duration: 156.284828ms)","trace[321412547] 'compare' (duration: 49.144955ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:13:11.237096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.550883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-6950adad-a774-4893-a78c-fac28997a5e1\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-04-21T17:13:11.237143Z","caller":"traceutil/trace.go:171","msg":"trace[549493681] range","detail":"{range_begin:/registry/persistentvolumes/pvc-6950adad-a774-4893-a78c-fac28997a5e1; range_end:; response_count:1; response_revision:4631; }","duration":"203.632708ms","start":"2026-04-21T17:13:11.033494Z","end":"2026-04-21T17:13:11.237127Z","steps":["trace[549493681] 'agreement among raft nodes before linearized reading' (duration: 203.376853ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:11.246072Z","caller":"traceutil/trace.go:171","msg":"trace[677284223] transaction","detail":"{read_only:false; response_revision:4632; number_of_response:1; }","duration":"206.489115ms","start":"2026-04-21T17:13:11.039556Z","end":"2026-04-21T17:13:11.246045Z","steps":["trace[677284223] 'process raft request' (duration: 206.271053ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:11.248162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.586889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2194894"} {"level":"info","ts":"2026-04-21T17:13:11.248267Z","caller":"traceutil/trace.go:171","msg":"trace[1385094183] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4635; }","duration":"199.691655ms","start":"2026-04-21T17:13:11.048539Z","end":"2026-04-21T17:13:11.248231Z","steps":["trace[1385094183] 'agreement among raft nodes before linearized reading' (duration: 198.093462ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:11.445258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.660461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-21T17:13:11.445261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.733679ms","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-04-21T17:13:11.445331Z","caller":"traceutil/trace.go:171","msg":"trace[825256220] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4641; }","duration":"101.767056ms","start":"2026-04-21T17:13:11.343549Z","end":"2026-04-21T17:13:11.445316Z","steps":["trace[825256220] 'range keys from in-memory index tree' (duration: 101.479019ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:11.445364Z","caller":"traceutil/trace.go:171","msg":"trace[2011319069] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4641; }","duration":"105.873757ms","start":"2026-04-21T17:13:11.339464Z","end":"2026-04-21T17:13:11.445338Z","steps":["trace[2011319069] 'range keys from in-memory index tree' (duration: 105.544407ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:11.445453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.933702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"warn","ts":"2026-04-21T17:13:11.445261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.373044ms","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-04-21T17:13:11.445512Z","caller":"traceutil/trace.go:171","msg":"trace[665307727] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4641; }","duration":"104.020678ms","start":"2026-04-21T17:13:11.341475Z","end":"2026-04-21T17:13:11.445496Z","steps":["trace[665307727] 'range keys from in-memory index tree' (duration: 103.830436ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:11.44552Z","caller":"traceutil/trace.go:171","msg":"trace[2095207766] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4641; }","duration":"100.665921ms","start":"2026-04-21T17:13:11.344843Z","end":"2026-04-21T17:13:11.445509Z","steps":["trace[2095207766] 'range keys from in-memory index tree' (duration: 100.262918ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:23.737114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.069805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:13:23.737204Z","caller":"traceutil/trace.go:171","msg":"trace[2100459910] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4822; }","duration":"161.223284ms","start":"2026-04-21T17:13:23.575961Z","end":"2026-04-21T17:13:23.737184Z","steps":["trace[2100459910] 'range keys from in-memory index tree' (duration: 160.992279ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:23.737182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.817719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-21T17:13:23.73764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.978347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-21T17:13:23.737597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.680886ms","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-04-21T17:13:23.737808Z","caller":"traceutil/trace.go:171","msg":"trace[1024987668] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4822; }","duration":"143.902159ms","start":"2026-04-21T17:13:23.593886Z","end":"2026-04-21T17:13:23.737788Z","steps":["trace[1024987668] 'range keys from in-memory index tree' (duration: 143.527438ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:23.737581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.967453ms","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-04-21T17:13:23.738061Z","caller":"traceutil/trace.go:171","msg":"trace[39840354] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4822; }","duration":"363.498485ms","start":"2026-04-21T17:13:23.374553Z","end":"2026-04-21T17:13:23.738051Z","steps":["trace[39840354] 'range keys from in-memory index tree' (duration: 362.767461ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:23.738098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:23.374526Z","time spent":"363.559499ms","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-21T17:13:23.738041Z","caller":"traceutil/trace.go:171","msg":"trace[1966296350] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4822; }","duration":"141.080923ms","start":"2026-04-21T17:13:23.596624Z","end":"2026-04-21T17:13:23.737705Z","steps":["trace[1966296350] 'range keys from in-memory index tree' (duration: 140.850229ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:23.737581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.350992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-21T17:13:23.738489Z","caller":"traceutil/trace.go:171","msg":"trace[1969651654] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4822; }","duration":"346.285577ms","start":"2026-04-21T17:13:23.392193Z","end":"2026-04-21T17:13:23.738478Z","steps":["trace[1969651654] 'range keys from in-memory index tree' (duration: 345.230075ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:13:23.737725Z","caller":"traceutil/trace.go:171","msg":"trace[566180723] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4822; }","duration":"140.389722ms","start":"2026-04-21T17:13:23.597294Z","end":"2026-04-21T17:13:23.737683Z","steps":["trace[566180723] 'range keys from in-memory index tree' (duration: 139.616236ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T17:13:23.738675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T17:13:23.392183Z","time spent":"346.398824ms","remote":"127.0.0.1:51002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-21T17:15:02.32951Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2905} {"level":"info","ts":"2026-04-21T17:15:02.427971Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2905,"took":"96.463197ms","hash":1947293684,"current-db-size-bytes":54001664,"current-db-size":"54 MB","current-db-size-in-use-bytes":29376512,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-21T17:15:02.428146Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1947293684,"revision":2905,"compact-revision":-1} {"level":"warn","ts":"2026-04-21T17:17:24.588694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.63716ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T17:17:24.589162Z","caller":"traceutil/trace.go:171","msg":"trace[691546047] linearizableReadLoop","detail":"{readStateIndex:6812; appliedIndex:6810; }","duration":"222.749139ms","start":"2026-04-21T17:17:24.366389Z","end":"2026-04-21T17:17:24.589138Z","steps":["trace[691546047] 'read index received' (duration: 16.607543ms)","trace[691546047] 'applied index is now lower than readState.Index' (duration: 206.140766ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T17:17:24.589163Z","caller":"traceutil/trace.go:171","msg":"trace[1293633310] transaction","detail":"{read_only:false; response_revision:6574; number_of_response:1; }","duration":"245.831519ms","start":"2026-04-21T17:17:24.343309Z","end":"2026-04-21T17:17:24.589141Z","steps":["trace[1293633310] 'process raft request' (duration: 245.472896ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:17:24.589182Z","caller":"traceutil/trace.go:171","msg":"trace[1971432795] transaction","detail":"{read_only:false; response_revision:6573; number_of_response:1; }","duration":"247.11018ms","start":"2026-04-21T17:17:24.342034Z","end":"2026-04-21T17:17:24.589144Z","steps":["trace[1971432795] 'process raft request' (duration: 40.953825ms)","trace[1971432795] 'compare' (duration: 205.5573ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T17:17:24.589286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.88954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T17:17:24.589426Z","caller":"traceutil/trace.go:171","msg":"trace[1263695175] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:6574; }","duration":"223.055863ms","start":"2026-04-21T17:17:24.366356Z","end":"2026-04-21T17:17:24.589412Z","steps":["trace[1263695175] 'agreement among raft nodes before linearized reading' (duration: 222.86596ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T17:20:02.339677Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5593} {"level":"info","ts":"2026-04-21T17:20:02.429951Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5593,"took":"88.629877ms","hash":378697186,"current-db-size-bytes":54001664,"current-db-size":"54 MB","current-db-size-in-use-bytes":17891328,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-21T17:20:02.430029Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":378697186,"revision":5593,"compact-revision":2905}