{"level":"warn","ts":"2026-04-14T10:44:11.177584Z","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-14T10:44:11.177695Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.136: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.136:2380","--initial-cluster=instance=https://199.19.213.136:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.136:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.136: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-14T10:44:11.177885Z","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-14T10:44:11.177969Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.136:2380"]} {"level":"info","ts":"2026-04-14T10:44:11.178017Z","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-14T10:44:11.178885Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.136:2379"]} {"level":"info","ts":"2026-04-14T10:44:11.179052Z","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.136:2380"],"listen-peer-urls":["https://199.19.213.136:2380"],"advertise-client-urls":["https://199.19.213.136:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.136:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.136: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-14T10:44:11.183864Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.407822ms"} {"level":"info","ts":"2026-04-14T10:44:11.190156Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"bcbe0b88c51dc5e5","cluster-id":"e591ddd6f6a32da9"} {"level":"info","ts":"2026-04-14T10:44:11.190317Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 switched to configuration voters=()"} {"level":"info","ts":"2026-04-14T10:44:11.19042Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 became follower at term 0"} {"level":"info","ts":"2026-04-14T10:44:11.190491Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft bcbe0b88c51dc5e5 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-14T10:44:11.190553Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 became follower at term 1"} {"level":"info","ts":"2026-04-14T10:44:11.19064Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 switched to configuration voters=(13600320606755997157)"} {"level":"warn","ts":"2026-04-14T10:44:11.19982Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-14T10:44:11.20139Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-14T10:44:11.202842Z","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-14T10:44:11.205573Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"bcbe0b88c51dc5e5","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-14T10:44:11.205689Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"bcbe0b88c51dc5e5","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-14T10:44:11.205721Z","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-14T10:44:11.205866Z","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-14T10:44:11.205881Z","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-14T10:44:11.210862Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 switched to configuration voters=(13600320606755997157)"} {"level":"info","ts":"2026-04-14T10:44:11.211022Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e591ddd6f6a32da9","local-member-id":"bcbe0b88c51dc5e5","added-peer-id":"bcbe0b88c51dc5e5","added-peer-peer-urls":["https://199.19.213.136:2380"]} {"level":"info","ts":"2026-04-14T10:44:11.212343Z","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-14T10:44:11.212641Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"bcbe0b88c51dc5e5","initial-advertise-peer-urls":["https://199.19.213.136:2380"],"listen-peer-urls":["https://199.19.213.136:2380"],"advertise-client-urls":["https://199.19.213.136:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.136:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-14T10:44:11.212674Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-14T10:44:11.212891Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.136:2380"} {"level":"info","ts":"2026-04-14T10:44:11.212916Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.136:2380"} {"level":"info","ts":"2026-04-14T10:44:11.592474Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 is starting a new election at term 1"} {"level":"info","ts":"2026-04-14T10:44:11.592526Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-14T10:44:11.592551Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 received MsgPreVoteResp from bcbe0b88c51dc5e5 at term 1"} {"level":"info","ts":"2026-04-14T10:44:11.592666Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 became candidate at term 2"} {"level":"info","ts":"2026-04-14T10:44:11.592719Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 received MsgVoteResp from bcbe0b88c51dc5e5 at term 2"} {"level":"info","ts":"2026-04-14T10:44:11.592759Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bcbe0b88c51dc5e5 became leader at term 2"} {"level":"info","ts":"2026-04-14T10:44:11.592777Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: bcbe0b88c51dc5e5 elected leader bcbe0b88c51dc5e5 at term 2"} {"level":"info","ts":"2026-04-14T10:44:11.594753Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"bcbe0b88c51dc5e5","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.136:2379]}","request-path":"/0/members/bcbe0b88c51dc5e5/attributes","cluster-id":"e591ddd6f6a32da9","publish-timeout":"7s"} {"level":"info","ts":"2026-04-14T10:44:11.594951Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-14T10:44:11.594997Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-14T10:44:11.595119Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T10:44:11.595205Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-14T10:44:11.595314Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-14T10:44:11.596478Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e591ddd6f6a32da9","local-member-id":"bcbe0b88c51dc5e5","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T10:44:11.596568Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T10:44:11.596592Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-14T10:44:11.59718Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-14T10:44:11.598377Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.136:2379"} {"level":"warn","ts":"2026-04-14T10:44:13.642517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.327474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-14T10:44:13.642513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.240353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-14T10:44:13.64264Z","caller":"traceutil/trace.go:171","msg":"trace[1551881253] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:69; }","duration":"311.557127ms","start":"2026-04-14T10:44:13.331062Z","end":"2026-04-14T10:44:13.642619Z","steps":["trace[1551881253] 'range keys from in-memory index tree' (duration: 311.202453ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:13.642711Z","caller":"traceutil/trace.go:171","msg":"trace[86749815] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:69; }","duration":"256.605318ms","start":"2026-04-14T10:44:13.386082Z","end":"2026-04-14T10:44:13.642687Z","steps":["trace[86749815] 'range keys from in-memory index tree' (duration: 256.126022ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:13.64294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:13.330993Z","time spent":"311.919421ms","remote":"127.0.0.1:51690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":28,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-04-14T10:44:13.795676Z","caller":"traceutil/trace.go:171","msg":"trace[987058231] transaction","detail":"{read_only:false; response_revision:70; number_of_response:1; }","duration":"147.863066ms","start":"2026-04-14T10:44:13.647794Z","end":"2026-04-14T10:44:13.795657Z","steps":["trace[987058231] 'process raft request' (duration: 147.647883ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:13.796364Z","caller":"traceutil/trace.go:171","msg":"trace[848576047] transaction","detail":"{read_only:false; response_revision:71; number_of_response:1; }","duration":"145.247645ms","start":"2026-04-14T10:44:13.651106Z","end":"2026-04-14T10:44:13.796354Z","steps":["trace[848576047] 'process raft request' (duration: 145.012822ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:29.253691Z","caller":"traceutil/trace.go:171","msg":"trace[886854980] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"117.852866ms","start":"2026-04-14T10:44:29.135808Z","end":"2026-04-14T10:44:29.253661Z","steps":["trace[886854980] 'process raft request' (duration: 69.454224ms)","trace[886854980] 'compare' (duration: 48.215771ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:44:29.253943Z","caller":"traceutil/trace.go:171","msg":"trace[1477485552] transaction","detail":"{read_only:false; response_revision:437; number_of_response:1; }","duration":"117.91105ms","start":"2026-04-14T10:44:29.135824Z","end":"2026-04-14T10:44:29.253735Z","steps":["trace[1477485552] 'process raft request' (duration: 117.768391ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:29.254093Z","caller":"traceutil/trace.go:171","msg":"trace[759036908] transaction","detail":"{read_only:false; response_revision:439; number_of_response:1; }","duration":"117.941453ms","start":"2026-04-14T10:44:29.136128Z","end":"2026-04-14T10:44:29.254069Z","steps":["trace[759036908] 'process raft request' (duration: 117.546967ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:29.254171Z","caller":"traceutil/trace.go:171","msg":"trace[1563521716] transaction","detail":"{read_only:false; response_revision:438; number_of_response:1; }","duration":"118.20507ms","start":"2026-04-14T10:44:29.135943Z","end":"2026-04-14T10:44:29.254148Z","steps":["trace[1563521716] 'process raft request' (duration: 117.692697ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:42.77321Z","caller":"traceutil/trace.go:171","msg":"trace[1167233370] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"153.850646ms","start":"2026-04-14T10:44:42.619339Z","end":"2026-04-14T10:44:42.77319Z","steps":["trace[1167233370] 'process raft request' (duration: 153.733199ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:42.83003Z","caller":"traceutil/trace.go:171","msg":"trace[1402935207] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"168.871318ms","start":"2026-04-14T10:44:42.661138Z","end":"2026-04-14T10:44:42.830009Z","steps":["trace[1402935207] 'process raft request' (duration: 168.831456ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:42.830095Z","caller":"traceutil/trace.go:171","msg":"trace[2092235661] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"206.455788ms","start":"2026-04-14T10:44:42.623597Z","end":"2026-04-14T10:44:42.830053Z","steps":["trace[2092235661] 'process raft request' (duration: 205.94076ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:42.830135Z","caller":"traceutil/trace.go:171","msg":"trace[833370969] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"206.511801ms","start":"2026-04-14T10:44:42.623613Z","end":"2026-04-14T10:44:42.830124Z","steps":["trace[833370969] 'process raft request' (duration: 206.027364ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:42.830353Z","caller":"traceutil/trace.go:171","msg":"trace[1794513468] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"195.344973ms","start":"2026-04-14T10:44:42.634995Z","end":"2026-04-14T10:44:42.83034Z","steps":["trace[1794513468] 'process raft request' (duration: 194.845486ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:42.830412Z","caller":"traceutil/trace.go:171","msg":"trace[1822002972] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"183.963883ms","start":"2026-04-14T10:44:42.64644Z","end":"2026-04-14T10:44:42.830404Z","steps":["trace[1822002972] 'process raft request' (duration: 183.428384ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:42.830355Z","caller":"traceutil/trace.go:171","msg":"trace[1370459212] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"180.46728ms","start":"2026-04-14T10:44:42.649865Z","end":"2026-04-14T10:44:42.830332Z","steps":["trace[1370459212] 'process raft request' (duration: 180.063387ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:42.830035Z","caller":"traceutil/trace.go:171","msg":"trace[1264280534] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"199.045518ms","start":"2026-04-14T10:44:42.630932Z","end":"2026-04-14T10:44:42.829977Z","steps":["trace[1264280534] 'process raft request' (duration: 198.738721ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:42.830489Z","caller":"traceutil/trace.go:171","msg":"trace[183967224] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"196.644795ms","start":"2026-04-14T10:44:42.633827Z","end":"2026-04-14T10:44:42.830472Z","steps":["trace[183967224] 'process raft request' (duration: 195.896104ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:42.830392Z","caller":"traceutil/trace.go:171","msg":"trace[1420392818] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"196.123067ms","start":"2026-04-14T10:44:42.633972Z","end":"2026-04-14T10:44:42.830095Z","steps":["trace[1420392818] 'process raft request' (duration: 195.780588ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:42.830591Z","caller":"traceutil/trace.go:171","msg":"trace[1121675823] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"198.490158ms","start":"2026-04-14T10:44:42.631811Z","end":"2026-04-14T10:44:42.830301Z","steps":["trace[1121675823] 'process raft request' (duration: 197.885695ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:48.287911Z","caller":"traceutil/trace.go:171","msg":"trace[933429709] linearizableReadLoop","detail":"{readStateIndex:631; appliedIndex:630; }","duration":"154.510215ms","start":"2026-04-14T10:44:48.133379Z","end":"2026-04-14T10:44:48.287889Z","steps":["trace[933429709] 'read index received' (duration: 154.367557ms)","trace[933429709] 'applied index is now lower than readState.Index' (duration: 141.737µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:44:48.287943Z","caller":"traceutil/trace.go:171","msg":"trace[967404134] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"253.204208ms","start":"2026-04-14T10:44:48.034708Z","end":"2026-04-14T10:44:48.287912Z","steps":["trace[967404134] 'process raft request' (duration: 253.041649ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:48.288107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.709014ms","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-14T10:44:48.288134Z","caller":"traceutil/trace.go:171","msg":"trace[860598343] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:609; }","duration":"154.791309ms","start":"2026-04-14T10:44:48.133334Z","end":"2026-04-14T10:44:48.288125Z","steps":["trace[860598343] 'agreement among raft nodes before linearized reading' (duration: 154.646591ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:49.551748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.174649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-14T10:44:49.551825Z","caller":"traceutil/trace.go:171","msg":"trace[1940735189] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:616; }","duration":"369.311596ms","start":"2026-04-14T10:44:49.182495Z","end":"2026-04-14T10:44:49.551807Z","steps":["trace[1940735189] 'range keys from in-memory index tree' (duration: 369.027562ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:49.551855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:49.182477Z","time spent":"369.372329ms","remote":"127.0.0.1:51568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-14T10:44:49.595638Z","caller":"traceutil/trace.go:171","msg":"trace[205062270] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"311.586728ms","start":"2026-04-14T10:44:49.284Z","end":"2026-04-14T10:44:49.595587Z","steps":["trace[205062270] 'process raft request' (duration: 311.017589ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:49.596261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:44:49.28395Z","time spent":"311.779517ms","remote":"127.0.0.1:51398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-14T10:44:49.761747Z","caller":"traceutil/trace.go:171","msg":"trace[594892749] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:640; }","duration":"139.781794ms","start":"2026-04-14T10:44:49.62194Z","end":"2026-04-14T10:44:49.761722Z","steps":["trace[594892749] 'read index received' (duration: 119.000389ms)","trace[594892749] 'applied index is now lower than readState.Index' (duration: 20.779614ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:44:49.761964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.459458ms","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-14T10:44:49.762003Z","caller":"traceutil/trace.go:171","msg":"trace[1546766317] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:619; }","duration":"141.554183ms","start":"2026-04-14T10:44:49.620438Z","end":"2026-04-14T10:44:49.761992Z","steps":["trace[1546766317] 'agreement among raft nodes before linearized reading' (duration: 141.373384ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:49.761781Z","caller":"traceutil/trace.go:171","msg":"trace[1913772590] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"147.474927ms","start":"2026-04-14T10:44:49.61426Z","end":"2026-04-14T10:44:49.761735Z","steps":["trace[1913772590] 'process raft request' (duration: 126.682492ms)","trace[1913772590] 'compare' (duration: 20.608656ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:44:50.370455Z","caller":"traceutil/trace.go:171","msg":"trace[54367484] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"188.801661ms","start":"2026-04-14T10:44:50.181622Z","end":"2026-04-14T10:44:50.370424Z","steps":["trace[54367484] 'process raft request' (duration: 188.117826ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:51.746718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.47291ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-14T10:44:51.746951Z","caller":"traceutil/trace.go:171","msg":"trace[1703990215] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"120.317654ms","start":"2026-04-14T10:44:51.626584Z","end":"2026-04-14T10:44:51.746902Z","steps":["trace[1703990215] 'process raft request' (duration: 19.35178ms)","trace[1703990215] 'compare' (duration: 100.337053ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:44:51.747042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.159956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T10:44:51.747295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.22345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-14T10:44:51.747333Z","caller":"traceutil/trace.go:171","msg":"trace[1139514321] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:647; }","duration":"120.297194ms","start":"2026-04-14T10:44:51.627021Z","end":"2026-04-14T10:44:51.747318Z","steps":["trace[1139514321] 'agreement among raft nodes before linearized reading' (duration: 120.158667ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:51.747329Z","caller":"traceutil/trace.go:171","msg":"trace[550612655] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:647; }","duration":"113.472941ms","start":"2026-04-14T10:44:51.633834Z","end":"2026-04-14T10:44:51.747307Z","steps":["trace[550612655] 'agreement among raft nodes before linearized reading' (duration: 113.059571ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:51.74735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.725205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:44:51.747419Z","caller":"traceutil/trace.go:171","msg":"trace[1564888695] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:0; response_revision:647; }","duration":"120.801669ms","start":"2026-04-14T10:44:51.626596Z","end":"2026-04-14T10:44:51.747398Z","steps":["trace[1564888695] 'agreement among raft nodes before linearized reading' (duration: 120.714055ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:51.747126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.428231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-14T10:44:51.747178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.329704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:44:51.747733Z","caller":"traceutil/trace.go:171","msg":"trace[1230250959] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:0; response_revision:647; }","duration":"113.923284ms","start":"2026-04-14T10:44:51.633793Z","end":"2026-04-14T10:44:51.747717Z","steps":["trace[1230250959] 'agreement among raft nodes before linearized reading' (duration: 113.288272ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:51.747157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.250611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:44:51.74794Z","caller":"traceutil/trace.go:171","msg":"trace[352027710] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:647; }","duration":"114.069431ms","start":"2026-04-14T10:44:51.633855Z","end":"2026-04-14T10:44:51.747925Z","steps":["trace[352027710] 'agreement among raft nodes before linearized reading' (duration: 113.079222ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:51.749006Z","caller":"traceutil/trace.go:171","msg":"trace[840934173] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"107.44962ms","start":"2026-04-14T10:44:51.641454Z","end":"2026-04-14T10:44:51.748903Z","steps":["trace[840934173] 'process raft request' (duration: 107.223018ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:51.749238Z","caller":"traceutil/trace.go:171","msg":"trace[1375472451] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"108.705872ms","start":"2026-04-14T10:44:51.640521Z","end":"2026-04-14T10:44:51.749227Z","steps":["trace[1375472451] 'process raft request' (duration: 107.664109ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:51.750254Z","caller":"traceutil/trace.go:171","msg":"trace[1136608160] linearizableReadLoop","detail":"{readStateIndex:670; appliedIndex:669; }","duration":"112.798277ms","start":"2026-04-14T10:44:51.634016Z","end":"2026-04-14T10:44:51.746814Z","steps":["trace[1136608160] 'read index received' (duration: 11.867315ms)","trace[1136608160] 'applied index is now lower than readState.Index' (duration: 100.929762ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:44:51.750876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.604666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:44:51.750913Z","caller":"traceutil/trace.go:171","msg":"trace[955434476] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:649; }","duration":"106.669169ms","start":"2026-04-14T10:44:51.644234Z","end":"2026-04-14T10:44:51.750903Z","steps":["trace[955434476] 'agreement among raft nodes before linearized reading' (duration: 106.605986ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:44:51.74769Z","caller":"traceutil/trace.go:171","msg":"trace[948671109] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:0; response_revision:647; }","duration":"119.991568ms","start":"2026-04-14T10:44:51.627629Z","end":"2026-04-14T10:44:51.74762Z","steps":["trace[948671109] 'agreement among raft nodes before linearized reading' (duration: 119.411309ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:51.751553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.508481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:44:51.75275Z","caller":"traceutil/trace.go:171","msg":"trace[652343094] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:649; }","duration":"107.709973ms","start":"2026-04-14T10:44:51.645011Z","end":"2026-04-14T10:44:51.752721Z","steps":["trace[652343094] 'agreement among raft nodes before linearized reading' (duration: 106.4739ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:44:51.751644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.326324ms","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-14T10:44:51.752884Z","caller":"traceutil/trace.go:171","msg":"trace[1216711718] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:649; }","duration":"108.596597ms","start":"2026-04-14T10:44:51.644278Z","end":"2026-04-14T10:44:51.752875Z","steps":["trace[1216711718] 'agreement among raft nodes before linearized reading' (duration: 107.257839ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:45:05.843495Z","caller":"traceutil/trace.go:171","msg":"trace[1483556185] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"143.837813ms","start":"2026-04-14T10:45:05.699618Z","end":"2026-04-14T10:45:05.843456Z","steps":["trace[1483556185] 'process raft request' (duration: 143.477398ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:45:06.00787Z","caller":"traceutil/trace.go:171","msg":"trace[1086209852] linearizableReadLoop","detail":"{readStateIndex:809; appliedIndex:808; }","duration":"149.261495ms","start":"2026-04-14T10:45:05.858587Z","end":"2026-04-14T10:45:06.007849Z","steps":["trace[1086209852] 'read index received' (duration: 123.102793ms)","trace[1086209852] 'applied index is now lower than readState.Index' (duration: 26.157752ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:45:06.008271Z","caller":"traceutil/trace.go:171","msg":"trace[1160124334] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"161.111169ms","start":"2026-04-14T10:45:05.847077Z","end":"2026-04-14T10:45:06.008188Z","steps":["trace[1160124334] 'process raft request' (duration: 134.715746ms)","trace[1160124334] 'compare' (duration: 25.956084ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:45:06.008517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.909283ms","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-14T10:45:06.008571Z","caller":"traceutil/trace.go:171","msg":"trace[425907905] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:782; }","duration":"150.008087ms","start":"2026-04-14T10:45:05.85855Z","end":"2026-04-14T10:45:06.008558Z","steps":["trace[425907905] 'agreement among raft nodes before linearized reading' (duration: 149.381719ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:46:34.71153Z","caller":"traceutil/trace.go:171","msg":"trace[413147845] transaction","detail":"{read_only:false; response_revision:1945; number_of_response:1; }","duration":"142.797359ms","start":"2026-04-14T10:46:34.568703Z","end":"2026-04-14T10:46:34.7115Z","steps":["trace[413147845] 'process raft request' (duration: 141.256194ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:46:34.711554Z","caller":"traceutil/trace.go:171","msg":"trace[770386402] transaction","detail":"{read_only:false; response_revision:1946; number_of_response:1; }","duration":"141.93646ms","start":"2026-04-14T10:46:34.569575Z","end":"2026-04-14T10:46:34.711511Z","steps":["trace[770386402] 'process raft request' (duration: 141.758965ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:46:54.696144Z","caller":"traceutil/trace.go:171","msg":"trace[1946085855] transaction","detail":"{read_only:false; response_revision:2071; number_of_response:1; }","duration":"114.315091ms","start":"2026-04-14T10:46:54.581804Z","end":"2026-04-14T10:46:54.69612Z","steps":["trace[1946085855] 'process raft request' (duration: 114.093007ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:00.0746Z","caller":"traceutil/trace.go:171","msg":"trace[1279258794] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"148.834195ms","start":"2026-04-14T10:46:59.925737Z","end":"2026-04-14T10:47:00.074571Z","steps":["trace[1279258794] 'process raft request' (duration: 67.873816ms)","trace[1279258794] 'compare' (duration: 80.446368ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:47:00.076017Z","caller":"traceutil/trace.go:171","msg":"trace[1941308988] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"142.372982ms","start":"2026-04-14T10:46:59.933632Z","end":"2026-04-14T10:47:00.076005Z","steps":["trace[1941308988] 'process raft request' (duration: 142.28246ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:00.893989Z","caller":"traceutil/trace.go:171","msg":"trace[417437431] transaction","detail":"{read_only:false; response_revision:2106; number_of_response:1; }","duration":"177.6155ms","start":"2026-04-14T10:47:00.716341Z","end":"2026-04-14T10:47:00.893957Z","steps":["trace[417437431] 'process raft request' (duration: 177.389905ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:00.986049Z","caller":"traceutil/trace.go:171","msg":"trace[24721672] linearizableReadLoop","detail":"{readStateIndex:2188; appliedIndex:2186; }","duration":"248.738686ms","start":"2026-04-14T10:47:00.737279Z","end":"2026-04-14T10:47:00.986017Z","steps":["trace[24721672] 'read index received' (duration: 156.439995ms)","trace[24721672] 'applied index is now lower than readState.Index' (duration: 92.297551ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:47:00.986179Z","caller":"traceutil/trace.go:171","msg":"trace[1687922151] transaction","detail":"{read_only:false; response_revision:2107; number_of_response:1; }","duration":"258.309742ms","start":"2026-04-14T10:47:00.727807Z","end":"2026-04-14T10:47:00.986117Z","steps":["trace[1687922151] 'process raft request' (duration: 257.975355ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:00.986444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.131324ms","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-14T10:47:00.986498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.841507ms","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-14T10:47:00.986575Z","caller":"traceutil/trace.go:171","msg":"trace[9565433] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2107; }","duration":"249.252436ms","start":"2026-04-14T10:47:00.737241Z","end":"2026-04-14T10:47:00.986493Z","steps":["trace[9565433] 'agreement among raft nodes before linearized reading' (duration: 248.974181ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:00.986623Z","caller":"traceutil/trace.go:171","msg":"trace[2113696393] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2107; }","duration":"123.00777ms","start":"2026-04-14T10:47:00.863578Z","end":"2026-04-14T10:47:00.986585Z","steps":["trace[2113696393] 'agreement among raft nodes before linearized reading' (duration: 122.711484ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:00.986749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.973992ms","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-14T10:47:00.987094Z","caller":"traceutil/trace.go:171","msg":"trace[782068719] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2107; }","duration":"109.36747ms","start":"2026-04-14T10:47:00.877711Z","end":"2026-04-14T10:47:00.987078Z","steps":["trace[782068719] 'agreement among raft nodes before linearized reading' (duration: 108.610775ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:01.164975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.23866ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T10:47:01.165236Z","caller":"traceutil/trace.go:171","msg":"trace[1933255797] linearizableReadLoop","detail":"{readStateIndex:2191; appliedIndex:2188; }","duration":"130.044836ms","start":"2026-04-14T10:47:01.035172Z","end":"2026-04-14T10:47:01.165216Z","steps":["trace[1933255797] 'read index received' (duration: 69.674443ms)","trace[1933255797] 'applied index is now lower than readState.Index' (duration: 60.369593ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:47:01.165377Z","caller":"traceutil/trace.go:171","msg":"trace[945436267] transaction","detail":"{read_only:false; response_revision:2109; number_of_response:1; }","duration":"173.577835ms","start":"2026-04-14T10:47:00.991782Z","end":"2026-04-14T10:47:01.16536Z","steps":["trace[945436267] 'process raft request' (duration: 173.32987ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:47:01.166388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.2629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-14T10:47:01.166802Z","caller":"traceutil/trace.go:171","msg":"trace[544984009] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:2110; }","duration":"131.521425ms","start":"2026-04-14T10:47:01.035125Z","end":"2026-04-14T10:47:01.166646Z","steps":["trace[544984009] 'agreement among raft nodes before linearized reading' (duration: 130.231499ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:01.165543Z","caller":"traceutil/trace.go:171","msg":"trace[1898745189] transaction","detail":"{read_only:false; response_revision:2110; number_of_response:1; }","duration":"173.28505ms","start":"2026-04-14T10:47:00.992248Z","end":"2026-04-14T10:47:01.165533Z","steps":["trace[1898745189] 'process raft request' (duration: 172.932052ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:47:01.167947Z","caller":"traceutil/trace.go:171","msg":"trace[916868614] transaction","detail":"{read_only:false; response_revision:2108; number_of_response:1; }","duration":"176.114897ms","start":"2026-04-14T10:47:00.991772Z","end":"2026-04-14T10:47:01.167887Z","steps":["trace[916868614] 'process raft request' (duration: 16.851935ms)","trace[916868614] 'compare' (duration: 156.095266ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:47:37.563827Z","caller":"traceutil/trace.go:171","msg":"trace[914028129] transaction","detail":"{read_only:false; response_revision:2314; number_of_response:1; }","duration":"119.747997ms","start":"2026-04-14T10:47:37.44405Z","end":"2026-04-14T10:47:37.563798Z","steps":["trace[914028129] 'process raft request' (duration: 51.618905ms)","trace[914028129] 'compare' (duration: 67.943968ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:47:55.641591Z","caller":"traceutil/trace.go:171","msg":"trace[742851636] transaction","detail":"{read_only:false; response_revision:2416; number_of_response:1; }","duration":"112.625915ms","start":"2026-04-14T10:47:55.528928Z","end":"2026-04-14T10:47:55.641554Z","steps":["trace[742851636] 'process raft request' (duration: 74.229608ms)","trace[742851636] 'compare' (duration: 38.141733ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:48:09.348213Z","caller":"traceutil/trace.go:171","msg":"trace[2031275984] transaction","detail":"{read_only:false; response_revision:2575; number_of_response:1; }","duration":"150.262403ms","start":"2026-04-14T10:48:09.197929Z","end":"2026-04-14T10:48:09.348192Z","steps":["trace[2031275984] 'process raft request' (duration: 150.129261ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:48:34.135759Z","caller":"traceutil/trace.go:171","msg":"trace[847920998] linearizableReadLoop","detail":"{readStateIndex:2816; appliedIndex:2815; }","duration":"168.296406ms","start":"2026-04-14T10:48:33.96744Z","end":"2026-04-14T10:48:34.135736Z","steps":["trace[847920998] 'read index received' (duration: 168.058122ms)","trace[847920998] 'applied index is now lower than readState.Index' (duration: 237.064µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:48:34.135931Z","caller":"traceutil/trace.go:171","msg":"trace[196472707] transaction","detail":"{read_only:false; response_revision:2714; number_of_response:1; }","duration":"203.77153ms","start":"2026-04-14T10:48:33.932099Z","end":"2026-04-14T10:48:34.13587Z","steps":["trace[196472707] 'process raft request' (duration: 203.478165ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:48:34.136106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.637601ms","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-14T10:48:34.136188Z","caller":"traceutil/trace.go:171","msg":"trace[1604974403] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2714; }","duration":"168.749014ms","start":"2026-04-14T10:48:33.96741Z","end":"2026-04-14T10:48:34.136159Z","steps":["trace[1604974403] 'agreement among raft nodes before linearized reading' (duration: 168.497909ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:48:34.136512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.064719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-14T10:48:34.136584Z","caller":"traceutil/trace.go:171","msg":"trace[376920536] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2714; }","duration":"159.1892ms","start":"2026-04-14T10:48:33.977379Z","end":"2026-04-14T10:48:34.136568Z","steps":["trace[376920536] 'agreement among raft nodes before linearized reading' (duration: 158.967786ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:48:34.247638Z","caller":"traceutil/trace.go:171","msg":"trace[1753920154] transaction","detail":"{read_only:false; response_revision:2716; number_of_response:1; }","duration":"106.974741ms","start":"2026-04-14T10:48:34.14063Z","end":"2026-04-14T10:48:34.247605Z","steps":["trace[1753920154] 'process raft request' (duration: 106.665296ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:48:39.720604Z","caller":"traceutil/trace.go:171","msg":"trace[1015661483] linearizableReadLoop","detail":"{readStateIndex:2845; appliedIndex:2844; }","duration":"179.839578ms","start":"2026-04-14T10:48:39.540739Z","end":"2026-04-14T10:48:39.720579Z","steps":["trace[1015661483] 'read index received' (duration: 179.604424ms)","trace[1015661483] 'applied index is now lower than readState.Index' (duration: 234.504µs)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:48:39.721081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.362204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:48:39.721117Z","caller":"traceutil/trace.go:171","msg":"trace[769304759] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2742; }","duration":"168.460896ms","start":"2026-04-14T10:48:39.552646Z","end":"2026-04-14T10:48:39.721107Z","steps":["trace[769304759] 'agreement among raft nodes before linearized reading' (duration: 168.382435ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:48:39.721178Z","caller":"traceutil/trace.go:171","msg":"trace[1397632769] transaction","detail":"{read_only:false; response_revision:2742; number_of_response:1; }","duration":"240.861413ms","start":"2026-04-14T10:48:39.480259Z","end":"2026-04-14T10:48:39.72112Z","steps":["trace[1397632769] 'process raft request' (duration: 240.160522ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:48:39.721932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.12678ms","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-14T10:48:39.721991Z","caller":"traceutil/trace.go:171","msg":"trace[499030937] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:2742; }","duration":"181.282043ms","start":"2026-04-14T10:48:39.540695Z","end":"2026-04-14T10:48:39.721977Z","steps":["trace[499030937] 'agreement among raft nodes before linearized reading' (duration: 181.12148ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:49:12.760593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.842247ms","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-14T10:49:12.760694Z","caller":"traceutil/trace.go:171","msg":"trace[1328165008] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2914; }","duration":"249.012792ms","start":"2026-04-14T10:49:12.511661Z","end":"2026-04-14T10:49:12.760674Z","steps":["trace[1328165008] 'range keys from in-memory index tree' (duration: 248.640051ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:49:12.760762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.867233ms","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-14T10:49:12.760805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.571212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-04-14T10:49:12.760959Z","caller":"traceutil/trace.go:171","msg":"trace[35818536] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2914; }","duration":"266.792468ms","start":"2026-04-14T10:49:12.494146Z","end":"2026-04-14T10:49:12.760939Z","steps":["trace[35818536] 'range keys from in-memory index tree' (duration: 266.374847ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:49:12.760745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.541604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:49:12.761118Z","caller":"traceutil/trace.go:171","msg":"trace[627181275] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2914; }","duration":"207.893864ms","start":"2026-04-14T10:49:12.553144Z","end":"2026-04-14T10:49:12.761038Z","steps":["trace[627181275] 'range keys from in-memory index tree' (duration: 207.467991ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:49:12.761143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.993737ms","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-14T10:49:12.761186Z","caller":"traceutil/trace.go:171","msg":"trace[1451311266] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2914; }","duration":"253.081799ms","start":"2026-04-14T10:49:12.508091Z","end":"2026-04-14T10:49:12.761173Z","steps":["trace[1451311266] 'range keys from in-memory index tree' (duration: 252.843112ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:49:12.760842Z","caller":"traceutil/trace.go:171","msg":"trace[408758021] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2914; }","duration":"354.999198ms","start":"2026-04-14T10:49:12.405826Z","end":"2026-04-14T10:49:12.760825Z","steps":["trace[408758021] 'range keys from in-memory index tree' (duration: 354.681998ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:49:12.761309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:49:12.405803Z","time spent":"355.488841ms","remote":"127.0.0.1:51568","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-14T10:49:12.761345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.94272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-14T10:49:12.761397Z","caller":"traceutil/trace.go:171","msg":"trace[1338563852] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2914; }","duration":"304.027213ms","start":"2026-04-14T10:49:12.457351Z","end":"2026-04-14T10:49:12.761378Z","steps":["trace[1338563852] 'range keys from in-memory index tree' (duration: 303.726714ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:49:12.761443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:49:12.457334Z","time spent":"304.098914ms","remote":"127.0.0.1:51568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-14T10:49:56.256078Z","caller":"traceutil/trace.go:171","msg":"trace[1543587375] transaction","detail":"{read_only:false; response_revision:3144; number_of_response:1; }","duration":"131.422211ms","start":"2026-04-14T10:49:56.124608Z","end":"2026-04-14T10:49:56.25603Z","steps":["trace[1543587375] 'process raft request' (duration: 131.152564ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:49:57.380353Z","caller":"traceutil/trace.go:171","msg":"trace[1997093275] transaction","detail":"{read_only:false; response_revision:3149; number_of_response:1; }","duration":"131.519596ms","start":"2026-04-14T10:49:57.248796Z","end":"2026-04-14T10:49:57.380315Z","steps":["trace[1997093275] 'process raft request' (duration: 127.39751ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:49:59.234772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.647132ms","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-14T10:49:59.234873Z","caller":"traceutil/trace.go:171","msg":"trace[1029583239] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3157; }","duration":"145.96944ms","start":"2026-04-14T10:49:59.088882Z","end":"2026-04-14T10:49:59.234852Z","steps":["trace[1029583239] 'range keys from in-memory index tree' (duration: 145.451257ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:49:59.575708Z","caller":"traceutil/trace.go:171","msg":"trace[575357370] transaction","detail":"{read_only:false; response_revision:3161; number_of_response:1; }","duration":"143.375413ms","start":"2026-04-14T10:49:59.432301Z","end":"2026-04-14T10:49:59.575676Z","steps":["trace[575357370] 'process raft request' (duration: 143.193978ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:49:59.608756Z","caller":"traceutil/trace.go:171","msg":"trace[314661656] transaction","detail":"{read_only:false; response_revision:3162; number_of_response:1; }","duration":"176.199725ms","start":"2026-04-14T10:49:59.432521Z","end":"2026-04-14T10:49:59.608721Z","steps":["trace[314661656] 'process raft request' (duration: 175.949189ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:49:59.608775Z","caller":"traceutil/trace.go:171","msg":"trace[21809864] transaction","detail":"{read_only:false; response_revision:3163; number_of_response:1; }","duration":"175.828716ms","start":"2026-04-14T10:49:59.432912Z","end":"2026-04-14T10:49:59.60874Z","steps":["trace[21809864] 'process raft request' (duration: 175.698042ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:49:59.608935Z","caller":"traceutil/trace.go:171","msg":"trace[226986160] transaction","detail":"{read_only:false; response_revision:3164; number_of_response:1; }","duration":"175.446255ms","start":"2026-04-14T10:49:59.433466Z","end":"2026-04-14T10:49:59.608913Z","steps":["trace[226986160] 'process raft request' (duration: 175.184618ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:50:00.27849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.296486ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-14T10:50:00.521179Z","caller":"traceutil/trace.go:171","msg":"trace[311232395] transaction","detail":"{read_only:false; response_revision:3166; number_of_response:1; }","duration":"102.609473ms","start":"2026-04-14T10:50:00.418514Z","end":"2026-04-14T10:50:00.521123Z","steps":["trace[311232395] 'process raft request' (duration: 90.72568ms)","trace[311232395] 'compare' (duration: 11.649607ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:50:00.685947Z","caller":"traceutil/trace.go:171","msg":"trace[2027812760] linearizableReadLoop","detail":"{readStateIndex:3288; appliedIndex:3287; }","duration":"158.860851ms","start":"2026-04-14T10:50:00.527027Z","end":"2026-04-14T10:50:00.685887Z","steps":["trace[2027812760] 'read index received' (duration: 141.178918ms)","trace[2027812760] 'applied index is now lower than readState.Index' (duration: 17.680463ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:50:00.685999Z","caller":"traceutil/trace.go:171","msg":"trace[36987141] transaction","detail":"{read_only:false; response_revision:3167; number_of_response:1; }","duration":"159.901198ms","start":"2026-04-14T10:50:00.526047Z","end":"2026-04-14T10:50:00.685949Z","steps":["trace[36987141] 'process raft request' (duration: 142.194624ms)","trace[36987141] 'compare' (duration: 17.447297ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:50:00.686227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.160438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak\" ","response":"range_response_count:1 size:1315"} {"level":"info","ts":"2026-04-14T10:50:00.686298Z","caller":"traceutil/trace.go:171","msg":"trace[738804237] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak; range_end:; response_count:1; response_revision:3167; }","duration":"159.282472ms","start":"2026-04-14T10:50:00.526999Z","end":"2026-04-14T10:50:00.686282Z","steps":["trace[738804237] 'agreement among raft nodes before linearized reading' (duration: 159.021485ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:50:00.686326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.859277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-14T10:50:00.686565Z","caller":"traceutil/trace.go:171","msg":"trace[555620913] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3167; }","duration":"133.088713ms","start":"2026-04-14T10:50:00.553416Z","end":"2026-04-14T10:50:00.686504Z","steps":["trace[555620913] 'agreement among raft nodes before linearized reading' (duration: 132.855367ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:50:00.686576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.655836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-14T10:50:00.68664Z","caller":"traceutil/trace.go:171","msg":"trace[825982403] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3167; }","duration":"115.756169ms","start":"2026-04-14T10:50:00.57087Z","end":"2026-04-14T10:50:00.686627Z","steps":["trace[825982403] 'agreement among raft nodes before linearized reading' (duration: 115.564294ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:50:01.540279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.60716ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-14T10:50:01.540483Z","caller":"traceutil/trace.go:171","msg":"trace[1042173257] transaction","detail":"{read_only:false; response_revision:3169; number_of_response:1; }","duration":"247.466941ms","start":"2026-04-14T10:50:01.292994Z","end":"2026-04-14T10:50:01.540461Z","steps":["trace[1042173257] 'process raft request' (duration: 89.585505ms)","trace[1042173257] 'compare' (duration: 157.482866ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:50:01.540793Z","caller":"traceutil/trace.go:171","msg":"trace[872929727] transaction","detail":"{read_only:false; response_revision:3170; number_of_response:1; }","duration":"107.621964ms","start":"2026-04-14T10:50:01.433146Z","end":"2026-04-14T10:50:01.540768Z","steps":["trace[872929727] 'process raft request' (duration: 107.246155ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:50:09.711831Z","caller":"traceutil/trace.go:171","msg":"trace[30308173] transaction","detail":"{read_only:false; response_revision:3210; number_of_response:1; }","duration":"119.946183ms","start":"2026-04-14T10:50:09.591853Z","end":"2026-04-14T10:50:09.711799Z","steps":["trace[30308173] 'process raft request' (duration: 111.524052ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:53:14.190565Z","caller":"traceutil/trace.go:171","msg":"trace[1007098605] transaction","detail":"{read_only:false; response_revision:4714; number_of_response:1; }","duration":"108.609836ms","start":"2026-04-14T10:53:14.081924Z","end":"2026-04-14T10:53:14.190534Z","steps":["trace[1007098605] 'process raft request' (duration: 104.327002ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:53:25.802267Z","caller":"traceutil/trace.go:171","msg":"trace[1655785506] transaction","detail":"{read_only:false; response_revision:4946; number_of_response:1; }","duration":"141.166461ms","start":"2026-04-14T10:53:25.661069Z","end":"2026-04-14T10:53:25.802236Z","steps":["trace[1655785506] 'process raft request' (duration: 140.770763ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:53:26.198473Z","caller":"traceutil/trace.go:171","msg":"trace[855762845] transaction","detail":"{read_only:false; response_revision:4952; number_of_response:1; }","duration":"216.891121ms","start":"2026-04-14T10:53:25.981503Z","end":"2026-04-14T10:53:26.198394Z","steps":["trace[855762845] 'process raft request' (duration: 216.646287ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:53:26.405478Z","caller":"traceutil/trace.go:171","msg":"trace[1908629044] transaction","detail":"{read_only:false; response_revision:4956; number_of_response:1; }","duration":"147.875608ms","start":"2026-04-14T10:53:26.257576Z","end":"2026-04-14T10:53:26.405452Z","steps":["trace[1908629044] 'process raft request' (duration: 142.226249ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:53:26.406055Z","caller":"traceutil/trace.go:171","msg":"trace[312634108] transaction","detail":"{read_only:false; response_revision:4957; number_of_response:1; }","duration":"148.01351ms","start":"2026-04-14T10:53:26.258007Z","end":"2026-04-14T10:53:26.406021Z","steps":["trace[312634108] 'process raft request' (duration: 147.539291ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:53:26.406131Z","caller":"traceutil/trace.go:171","msg":"trace[1213168798] transaction","detail":"{read_only:false; response_revision:4959; number_of_response:1; }","duration":"147.232195ms","start":"2026-04-14T10:53:26.258878Z","end":"2026-04-14T10:53:26.406111Z","steps":["trace[1213168798] 'process raft request' (duration: 147.00957ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:53:26.406279Z","caller":"traceutil/trace.go:171","msg":"trace[880828910] transaction","detail":"{read_only:false; response_revision:4958; number_of_response:1; }","duration":"147.854757ms","start":"2026-04-14T10:53:26.258413Z","end":"2026-04-14T10:53:26.406268Z","steps":["trace[880828910] 'process raft request' (duration: 147.410918ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:53:26.406801Z","caller":"traceutil/trace.go:171","msg":"trace[1596691321] transaction","detail":"{read_only:false; response_revision:4963; number_of_response:1; }","duration":"106.415236ms","start":"2026-04-14T10:53:26.30037Z","end":"2026-04-14T10:53:26.406785Z","steps":["trace[1596691321] 'process raft request' (duration: 106.382386ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:53:26.40693Z","caller":"traceutil/trace.go:171","msg":"trace[2010958159] transaction","detail":"{read_only:false; response_revision:4960; number_of_response:1; }","duration":"140.486855ms","start":"2026-04-14T10:53:26.266326Z","end":"2026-04-14T10:53:26.406813Z","steps":["trace[2010958159] 'process raft request' (duration: 139.651208ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:53:26.4071Z","caller":"traceutil/trace.go:171","msg":"trace[1932341056] linearizableReadLoop","detail":"{readStateIndex:5149; appliedIndex:5143; }","duration":"135.909936ms","start":"2026-04-14T10:53:26.271181Z","end":"2026-04-14T10:53:26.407091Z","steps":["trace[1932341056] 'read index received' (duration: 14.381847ms)","trace[1932341056] 'applied index is now lower than readState.Index' (duration: 121.526869ms)"],"step_count":2} {"level":"warn","ts":"2026-04-14T10:53:26.407315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.12066ms","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-14T10:53:26.407417Z","caller":"traceutil/trace.go:171","msg":"trace[1571580547] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4963; }","duration":"136.259283ms","start":"2026-04-14T10:53:26.271146Z","end":"2026-04-14T10:53:26.407406Z","steps":["trace[1571580547] 'agreement among raft nodes before linearized reading' (duration: 136.11131ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:53:26.407735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.126409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:130208"} {"level":"info","ts":"2026-04-14T10:53:26.408165Z","caller":"traceutil/trace.go:171","msg":"trace[1023262592] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:4963; }","duration":"108.588859ms","start":"2026-04-14T10:53:26.299569Z","end":"2026-04-14T10:53:26.408158Z","steps":["trace[1023262592] 'agreement among raft nodes before linearized reading' (duration: 108.039188ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:53:26.407962Z","caller":"traceutil/trace.go:171","msg":"trace[1323292583] transaction","detail":"{read_only:false; response_revision:4962; number_of_response:1; }","duration":"108.307944ms","start":"2026-04-14T10:53:26.299643Z","end":"2026-04-14T10:53:26.407951Z","steps":["trace[1323292583] 'process raft request' (duration: 107.07832ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:53:26.408045Z","caller":"traceutil/trace.go:171","msg":"trace[332475082] transaction","detail":"{read_only:false; response_revision:4961; number_of_response:1; }","duration":"108.409625ms","start":"2026-04-14T10:53:26.299629Z","end":"2026-04-14T10:53:26.408039Z","steps":["trace[332475082] 'process raft request' (duration: 107.043299ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:53:29.411286Z","caller":"traceutil/trace.go:171","msg":"trace[638096530] linearizableReadLoop","detail":"{readStateIndex:5230; appliedIndex:5229; }","duration":"175.71183ms","start":"2026-04-14T10:53:29.235549Z","end":"2026-04-14T10:53:29.411261Z","steps":["trace[638096530] 'read index received' (duration: 175.644149ms)","trace[638096530] 'applied index is now lower than readState.Index' (duration: 66.621µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:53:29.411407Z","caller":"traceutil/trace.go:171","msg":"trace[507403769] transaction","detail":"{read_only:false; response_revision:5041; number_of_response:1; }","duration":"190.933893ms","start":"2026-04-14T10:53:29.220435Z","end":"2026-04-14T10:53:29.411369Z","steps":["trace[507403769] 'process raft request' (duration: 190.646788ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:53:29.411513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.942974ms","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-14T10:53:29.41156Z","caller":"traceutil/trace.go:171","msg":"trace[1364715467] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5041; }","duration":"176.003785ms","start":"2026-04-14T10:53:29.235543Z","end":"2026-04-14T10:53:29.411547Z","steps":["trace[1364715467] 'agreement among raft nodes before linearized reading' (duration: 175.840042ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:53:34.374042Z","caller":"traceutil/trace.go:171","msg":"trace[180204272] linearizableReadLoop","detail":"{readStateIndex:5326; appliedIndex:5325; }","duration":"105.151733ms","start":"2026-04-14T10:53:34.268862Z","end":"2026-04-14T10:53:34.374014Z","steps":["trace[180204272] 'read index received' (duration: 104.650972ms)","trace[180204272] 'applied index is now lower than readState.Index' (duration: 499.471µs)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:53:34.374098Z","caller":"traceutil/trace.go:171","msg":"trace[2139661379] transaction","detail":"{read_only:false; response_revision:5133; number_of_response:1; }","duration":"116.703944ms","start":"2026-04-14T10:53:34.257348Z","end":"2026-04-14T10:53:34.374052Z","steps":["trace[2139661379] 'process raft request' (duration: 116.251395ms)"],"step_count":1} {"level":"warn","ts":"2026-04-14T10:53:34.374378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.484919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-04-14T10:53:34.374439Z","caller":"traceutil/trace.go:171","msg":"trace[386737593] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5133; }","duration":"105.596501ms","start":"2026-04-14T10:53:34.268826Z","end":"2026-04-14T10:53:34.374422Z","steps":["trace[386737593] 'agreement among raft nodes before linearized reading' (duration: 105.317146ms)"],"step_count":1} {"level":"info","ts":"2026-04-14T10:53:38.623504Z","caller":"traceutil/trace.go:171","msg":"trace[2047353496] transaction","detail":"{read_only:false; response_revision:5186; number_of_response:1; }","duration":"106.865972ms","start":"2026-04-14T10:53:38.516597Z","end":"2026-04-14T10:53:38.623463Z","steps":["trace[2047353496] 'process raft request' (duration: 87.264185ms)","trace[2047353496] 'compare' (duration: 19.273219ms)"],"step_count":2} {"level":"info","ts":"2026-04-14T10:54:11.766181Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2910} {"level":"info","ts":"2026-04-14T10:54:11.886881Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2910,"took":"119.556095ms","hash":2239087398,"current-db-size-bytes":52224000,"current-db-size":"52 MB","current-db-size-in-use-bytes":28151808,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-04-14T10:54:11.886937Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2239087398,"revision":2910,"compact-revision":-1} {"level":"info","ts":"2026-04-14T10:59:11.772482Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5488} {"level":"info","ts":"2026-04-14T10:59:11.846838Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5488,"took":"72.38079ms","hash":2753518686,"current-db-size-bytes":52224000,"current-db-size":"52 MB","current-db-size-in-use-bytes":18661376,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-04-14T10:59:11.846887Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2753518686,"revision":5488,"compact-revision":2910}