{"level":"warn","ts":"2026-06-13T01:02:32.568771Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-13T01:02:32.568911Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.227: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.204.45.227:2380","--initial-cluster=instance=https://199.204.45.227:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.227:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.227: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-06-13T01:02:32.569013Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-13T01:02:32.569029Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-06-13T01:02:32.56905Z","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-06-13T01:02:32.569804Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"]} {"level":"info","ts":"2026-06-13T01:02:32.569918Z","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.204.45.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.227: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-06-13T01:02:32.574141Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.934763ms"} {"level":"info","ts":"2026-06-13T01:02:32.584813Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"572db18442eba1c2","cluster-id":"fb1028a037bf3cd6"} {"level":"info","ts":"2026-06-13T01:02:32.584921Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=()"} {"level":"info","ts":"2026-06-13T01:02:32.584953Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 0"} {"level":"info","ts":"2026-06-13T01:02:32.584969Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 572db18442eba1c2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-13T01:02:32.584983Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 1"} {"level":"info","ts":"2026-06-13T01:02:32.585026Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"warn","ts":"2026-06-13T01:02:32.593061Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-13T01:02:32.594681Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-13T01:02:32.596113Z","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-06-13T01:02:32.599671Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"572db18442eba1c2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-13T01:02:32.605236Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"572db18442eba1c2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-13T01:02:32.60528Z","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-06-13T01:02:32.605379Z","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-06-13T01:02:32.605395Z","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-06-13T01:02:32.607454Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"info","ts":"2026-06-13T01:02:32.607628Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","added-peer-id":"572db18442eba1c2","added-peer-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-06-13T01:02:32.609126Z","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-06-13T01:02:32.609403Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-06-13T01:02:32.609544Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-06-13T01:02:32.611412Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"572db18442eba1c2","initial-advertise-peer-urls":["https://199.204.45.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-13T01:02:32.611521Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-13T01:02:33.085729Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 is starting a new election at term 1"} {"level":"info","ts":"2026-06-13T01:02:33.085814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-13T01:02:33.085845Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgPreVoteResp from 572db18442eba1c2 at term 1"} {"level":"info","ts":"2026-06-13T01:02:33.085984Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became candidate at term 2"} {"level":"info","ts":"2026-06-13T01:02:33.086006Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgVoteResp from 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-06-13T01:02:33.086021Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became leader at term 2"} {"level":"info","ts":"2026-06-13T01:02:33.08604Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 572db18442eba1c2 elected leader 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-06-13T01:02:33.086995Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"572db18442eba1c2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.227:2379]}","request-path":"/0/members/572db18442eba1c2/attributes","cluster-id":"fb1028a037bf3cd6","publish-timeout":"7s"} {"level":"info","ts":"2026-06-13T01:02:33.08704Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-13T01:02:33.087128Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-13T01:02:33.087618Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-13T01:02:33.08797Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-13T01:02:33.088014Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-13T01:02:33.08894Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","cluster-version":"3.5"} {"level":"info","ts":"2026-06-13T01:02:33.089159Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-13T01:02:33.089268Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-13T01:02:33.09064Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-13T01:02:33.09132Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.227:2379"} {"level":"info","ts":"2026-06-13T01:03:01.50776Z","caller":"traceutil/trace.go:171","msg":"trace[1386538401] linearizableReadLoop","detail":"{readStateIndex:487; appliedIndex:486; }","duration":"104.143374ms","start":"2026-06-13T01:03:01.403598Z","end":"2026-06-13T01:03:01.507741Z","steps":["trace[1386538401] 'read index received' (duration: 104.038913ms)","trace[1386538401] 'applied index is now lower than readState.Index' (duration: 103.771µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:03:01.507849Z","caller":"traceutil/trace.go:171","msg":"trace[730359993] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"142.198796ms","start":"2026-06-13T01:03:01.365612Z","end":"2026-06-13T01:03:01.507811Z","steps":["trace[730359993] 'process raft request' (duration: 142.032194ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:01.507895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.284265ms","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-06-13T01:03:01.507943Z","caller":"traceutil/trace.go:171","msg":"trace[1335415609] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:469; }","duration":"104.372035ms","start":"2026-06-13T01:03:01.403563Z","end":"2026-06-13T01:03:01.507935Z","steps":["trace[1335415609] 'agreement among raft nodes before linearized reading' (duration: 104.262685ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:01.719864Z","caller":"traceutil/trace.go:171","msg":"trace[1863148577] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"208.030245ms","start":"2026-06-13T01:03:01.511785Z","end":"2026-06-13T01:03:01.719816Z","steps":["trace[1863148577] 'process raft request' (duration: 151.925298ms)","trace[1863148577] 'compare' (duration: 55.922086ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:03:01.719939Z","caller":"traceutil/trace.go:171","msg":"trace[120739784] linearizableReadLoop","detail":"{readStateIndex:488; appliedIndex:487; }","duration":"182.315555ms","start":"2026-06-13T01:03:01.537576Z","end":"2026-06-13T01:03:01.719891Z","steps":["trace[120739784] 'read index received' (duration: 126.188268ms)","trace[120739784] 'applied index is now lower than readState.Index' (duration: 56.122797ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T01:03:01.721241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.646955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T01:03:01.721308Z","caller":"traceutil/trace.go:171","msg":"trace[2143740980] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:470; }","duration":"183.745286ms","start":"2026-06-13T01:03:01.53754Z","end":"2026-06-13T01:03:01.721286Z","steps":["trace[2143740980] 'agreement among raft nodes before linearized reading' (duration: 182.467526ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:09.130192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.459383ms","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-06-13T01:03:09.130251Z","caller":"traceutil/trace.go:171","msg":"trace[1578503580] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:520; }","duration":"334.554623ms","start":"2026-06-13T01:03:08.795684Z","end":"2026-06-13T01:03:09.130238Z","steps":["trace[1578503580] 'range keys from in-memory index tree' (duration: 334.393303ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:09.130273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:08.79567Z","time spent":"334.598254ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-13T01:03:09.130588Z","caller":"traceutil/trace.go:171","msg":"trace[1039157301] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"317.264073ms","start":"2026-06-13T01:03:08.813305Z","end":"2026-06-13T01:03:09.130569Z","steps":["trace[1039157301] 'process raft request' (duration: 223.892615ms)","trace[1039157301] 'compare' (duration: 93.065376ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T01:03:09.131261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:08.813286Z","time spent":"317.351124ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T01:03:09.36348Z","caller":"traceutil/trace.go:171","msg":"trace[1287976406] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"528.574639ms","start":"2026-06-13T01:03:08.834868Z","end":"2026-06-13T01:03:09.363443Z","steps":["trace[1287976406] 'process raft request' (duration: 528.473598ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:09.363575Z","caller":"traceutil/trace.go:171","msg":"trace[834457562] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"499.505385ms","start":"2026-06-13T01:03:08.864035Z","end":"2026-06-13T01:03:09.363541Z","steps":["trace[834457562] 'process raft request' (duration: 499.401455ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:09.363627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:08.834846Z","time spent":"528.71168ms","remote":"127.0.0.1:45852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-13T01:03:09.363607Z","caller":"traceutil/trace.go:171","msg":"trace[945050583] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"515.262956ms","start":"2026-06-13T01:03:08.848317Z","end":"2026-06-13T01:03:09.36358Z","steps":["trace[945050583] 'process raft request' (duration: 515.052704ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:09.363576Z","caller":"traceutil/trace.go:171","msg":"trace[1521329507] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"506.787576ms","start":"2026-06-13T01:03:08.856733Z","end":"2026-06-13T01:03:09.36352Z","steps":["trace[1521329507] 'process raft request' (duration: 506.672056ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:09.363768Z","caller":"traceutil/trace.go:171","msg":"trace[1174871031] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"499.607017ms","start":"2026-06-13T01:03:08.864151Z","end":"2026-06-13T01:03:09.363758Z","steps":["trace[1174871031] 'process raft request' (duration: 499.338285ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:09.363755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:08.848297Z","time spent":"515.394146ms","remote":"127.0.0.1:45852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-13T01:03:09.363791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:08.864019Z","time spent":"499.666487ms","remote":"127.0.0.1:45852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-13T01:03:09.363808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:08.864147Z","time spent":"499.644067ms","remote":"127.0.0.1:45852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-13T01:03:09.363888Z","caller":"traceutil/trace.go:171","msg":"trace[118337423] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"499.788468ms","start":"2026-06-13T01:03:08.864086Z","end":"2026-06-13T01:03:09.363874Z","steps":["trace[118337423] 'process raft request' (duration: 499.377915ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:09.363935Z","caller":"traceutil/trace.go:171","msg":"trace[622868332] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"492.860409ms","start":"2026-06-13T01:03:08.871064Z","end":"2026-06-13T01:03:09.363925Z","steps":["trace[622868332] 'process raft request' (duration: 492.480267ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:09.363936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:08.864083Z","time spent":"499.833368ms","remote":"127.0.0.1:45852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-13T01:03:09.363964Z","caller":"traceutil/trace.go:171","msg":"trace[410780520] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"488.564279ms","start":"2026-06-13T01:03:08.875362Z","end":"2026-06-13T01:03:09.363927Z","steps":["trace[410780520] 'process raft request' (duration: 488.215457ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:09.363991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:08.871057Z","time spent":"492.909089ms","remote":"127.0.0.1:45852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-13T01:03:09.364029Z","caller":"traceutil/trace.go:171","msg":"trace[346993040] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"482.152534ms","start":"2026-06-13T01:03:08.881868Z","end":"2026-06-13T01:03:09.36402Z","steps":["trace[346993040] 'process raft request' (duration: 481.760411ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:09.364029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:08.875354Z","time spent":"488.634249ms","remote":"127.0.0.1:45852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-13T01:03:09.364066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:08.881859Z","time spent":"482.188974ms","remote":"127.0.0.1:45852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-13T01:03:09.364143Z","caller":"traceutil/trace.go:171","msg":"trace[1570166823] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"535.349828ms","start":"2026-06-13T01:03:08.828052Z","end":"2026-06-13T01:03:09.363402Z","steps":["trace[1570166823] 'process raft request' (duration: 535.212227ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:09.364161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:08.856717Z","time spent":"506.998708ms","remote":"127.0.0.1:45852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-13T01:03:09.364086Z","caller":"traceutil/trace.go:171","msg":"trace[1763183122] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"466.512105ms","start":"2026-06-13T01:03:08.897564Z","end":"2026-06-13T01:03:09.364076Z","steps":["trace[1763183122] 'process raft request' (duration: 466.245893ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:09.364083Z","caller":"traceutil/trace.go:171","msg":"trace[1049123475] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"355.363517ms","start":"2026-06-13T01:03:09.008694Z","end":"2026-06-13T01:03:09.364058Z","steps":["trace[1049123475] 'process raft request' (duration: 355.269286ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:09.364669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:09.008671Z","time spent":"355.969771ms","remote":"127.0.0.1:45852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-13T01:03:09.364576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:08.897544Z","time spent":"466.956208ms","remote":"127.0.0.1:45852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-13T01:03:09.364965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:08.828019Z","time spent":"536.203943ms","remote":"127.0.0.1:45852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-13T01:03:09.371329Z","caller":"traceutil/trace.go:171","msg":"trace[290500797] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"237.477907ms","start":"2026-06-13T01:03:09.133838Z","end":"2026-06-13T01:03:09.371316Z","steps":["trace[290500797] 'process raft request' (duration: 237.374047ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:16.079366Z","caller":"traceutil/trace.go:171","msg":"trace[206817366] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"454.152676ms","start":"2026-06-13T01:03:15.625188Z","end":"2026-06-13T01:03:16.07934Z","steps":["trace[206817366] 'process raft request' (duration: 453.984315ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:16.079556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:15.625168Z","time spent":"454.300577ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T01:03:16.079794Z","caller":"traceutil/trace.go:171","msg":"trace[835515899] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:656; }","duration":"431.754658ms","start":"2026-06-13T01:03:15.647989Z","end":"2026-06-13T01:03:16.079744Z","steps":["trace[835515899] 'read index received' (duration: 431.733387ms)","trace[835515899] 'applied index is now lower than readState.Index' (duration: 18.35µs)"],"step_count":2} {"level":"warn","ts":"2026-06-13T01:03:16.080002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.993309ms","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-06-13T01:03:16.080042Z","caller":"traceutil/trace.go:171","msg":"trace[1511677548] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:629; }","duration":"432.080939ms","start":"2026-06-13T01:03:15.64795Z","end":"2026-06-13T01:03:16.080031Z","steps":["trace[1511677548] 'agreement among raft nodes before linearized reading' (duration: 431.951608ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:16.080078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:15.647935Z","time spent":"432.1359ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-13T01:03:16.58015Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656053326625017463,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-13T01:03:16.66819Z","caller":"traceutil/trace.go:171","msg":"trace[862296063] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"939.136465ms","start":"2026-06-13T01:03:15.729028Z","end":"2026-06-13T01:03:16.668165Z","steps":["trace[862296063] 'process raft request' (duration: 938.580402ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:16.668429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:15.728997Z","time spent":"939.267686ms","remote":"127.0.0.1:45910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T01:03:17.559679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.580978ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T01:03:17.559879Z","caller":"traceutil/trace.go:171","msg":"trace[2064091393] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:656; }","duration":"1.479986852s","start":"2026-06-13T01:03:16.079871Z","end":"2026-06-13T01:03:17.559858Z","steps":["trace[2064091393] 'read index received' (duration: 587.662342ms)","trace[2064091393] 'applied index is now lower than readState.Index' (duration: 892.32284ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:03:17.559967Z","caller":"traceutil/trace.go:171","msg":"trace[45392057] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"1.47512923s","start":"2026-06-13T01:03:16.08483Z","end":"2026-06-13T01:03:17.55996Z","steps":["trace[45392057] 'process raft request' (duration: 1.160975968s)","trace[45392057] 'compare' (duration: 313.462077ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:03:17.559884Z","caller":"traceutil/trace.go:171","msg":"trace[1146109618] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"834.571648ms","start":"2026-06-13T01:03:16.725292Z","end":"2026-06-13T01:03:17.559864Z","steps":["trace[1146109618] 'process raft request' (duration: 834.503177ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:17.560057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:16.084805Z","time spent":"1.475186651s","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T01:03:17.560151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:16.725267Z","time spent":"834.8082ms","remote":"127.0.0.1:46068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-13T01:03:17.560221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.778911746s","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-06-13T01:03:17.560242Z","caller":"traceutil/trace.go:171","msg":"trace[1711229911] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:632; }","duration":"1.778954846s","start":"2026-06-13T01:03:15.781281Z","end":"2026-06-13T01:03:17.560236Z","steps":["trace[1711229911] 'agreement among raft nodes before linearized reading' (duration: 1.778843456s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:17.560257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:15.781264Z","time spent":"1.778989966s","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-13T01:03:17.560268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.37053046s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.227\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-13T01:03:17.560324Z","caller":"traceutil/trace.go:171","msg":"trace[801491746] range","detail":"{range_begin:/registry/masterleases/199.204.45.227; range_end:; response_count:1; response_revision:632; }","duration":"1.370658781s","start":"2026-06-13T01:03:16.189652Z","end":"2026-06-13T01:03:17.560311Z","steps":["trace[801491746] 'agreement among raft nodes before linearized reading' (duration: 1.37054618s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:17.560334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.01642604s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T01:03:17.560352Z","caller":"traceutil/trace.go:171","msg":"trace[2075512235] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:632; }","duration":"1.016477761s","start":"2026-06-13T01:03:16.54387Z","end":"2026-06-13T01:03:17.560348Z","steps":["trace[2075512235] 'agreement among raft nodes before linearized reading' (duration: 1.016445941s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:17.560353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:16.189624Z","time spent":"1.370723381s","remote":"127.0.0.1:45834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.227\" "} {"level":"warn","ts":"2026-06-13T01:03:17.560363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:16.54385Z","time spent":"1.016510741s","remote":"127.0.0.1:45800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-13T01:03:17.560433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"961.287216ms","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-06-13T01:03:17.560529Z","caller":"traceutil/trace.go:171","msg":"trace[1247101796] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:632; }","duration":"961.443727ms","start":"2026-06-13T01:03:16.599063Z","end":"2026-06-13T01:03:17.560506Z","steps":["trace[1247101796] 'agreement among raft nodes before linearized reading' (duration: 961.225796ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:17.560554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.26159415s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-c222z\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-06-13T01:03:17.560571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:16.599043Z","time spent":"961.517967ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-13T01:03:17.560614Z","caller":"traceutil/trace.go:171","msg":"trace[274769988] range","detail":"{range_begin:/registry/pods/kube-system/cilium-c222z; range_end:; response_count:1; response_revision:632; }","duration":"1.26169371s","start":"2026-06-13T01:03:16.298907Z","end":"2026-06-13T01:03:17.5606Z","steps":["trace[274769988] 'agreement among raft nodes before linearized reading' (duration: 1.26157711s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:17.560604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.508812ms","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-06-13T01:03:17.560641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:16.298886Z","time spent":"1.261750361s","remote":"127.0.0.1:46014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-c222z\" "} {"level":"info","ts":"2026-06-13T01:03:17.56066Z","caller":"traceutil/trace.go:171","msg":"trace[1146177359] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:632; }","duration":"146.614833ms","start":"2026-06-13T01:03:17.414032Z","end":"2026-06-13T01:03:17.560647Z","steps":["trace[1146177359] 'agreement among raft nodes before linearized reading' (duration: 146.445262ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:17.870858Z","caller":"traceutil/trace.go:171","msg":"trace[2084847573] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"272.144686ms","start":"2026-06-13T01:03:17.598656Z","end":"2026-06-13T01:03:17.870801Z","steps":["trace[2084847573] 'process raft request' (duration: 272.098085ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:17.871021Z","caller":"traceutil/trace.go:171","msg":"trace[2135987501] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"303.897014ms","start":"2026-06-13T01:03:17.567001Z","end":"2026-06-13T01:03:17.870898Z","steps":["trace[2135987501] 'process raft request' (duration: 303.43421ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:17.871117Z","caller":"traceutil/trace.go:171","msg":"trace[552365974] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"295.581701ms","start":"2026-06-13T01:03:17.575525Z","end":"2026-06-13T01:03:17.871106Z","steps":["trace[552365974] 'process raft request' (duration: 295.091617ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:17.871102Z","caller":"traceutil/trace.go:171","msg":"trace[776800120] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"301.361748ms","start":"2026-06-13T01:03:17.569706Z","end":"2026-06-13T01:03:17.871068Z","steps":["trace[776800120] 'process raft request' (duration: 300.802224ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:17.871325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:17.566971Z","time spent":"304.165407ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T01:03:17.871521Z","caller":"traceutil/trace.go:171","msg":"trace[374680313] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"304.71162ms","start":"2026-06-13T01:03:17.566795Z","end":"2026-06-13T01:03:17.871507Z","steps":["trace[374680313] 'process raft request' (duration: 264.272334ms)","trace[374680313] 'compare' (duration: 39.010016ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T01:03:17.871522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:17.569693Z","time spent":"301.60049ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T01:03:17.871625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.860405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-06-13T01:03:17.871839Z","caller":"traceutil/trace.go:171","msg":"trace[1350951945] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:637; }","duration":"304.097666ms","start":"2026-06-13T01:03:17.56773Z","end":"2026-06-13T01:03:17.871828Z","steps":["trace[1350951945] 'agreement among raft nodes before linearized reading' (duration: 303.823614ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:17.871899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:17.567717Z","time spent":"304.173946ms","remote":"127.0.0.1:46032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-06-13T01:03:17.871658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:17.56675Z","time spent":"304.829631ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T01:03:17.871527Z","caller":"traceutil/trace.go:171","msg":"trace[1680202630] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:660; }","duration":"273.554035ms","start":"2026-06-13T01:03:17.597958Z","end":"2026-06-13T01:03:17.871512Z","steps":["trace[1680202630] 'read index received' (duration: 233.125639ms)","trace[1680202630] 'applied index is now lower than readState.Index' (duration: 40.426886ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T01:03:17.872146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.05247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T01:03:17.872174Z","caller":"traceutil/trace.go:171","msg":"trace[1940184612] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:637; }","duration":"268.11134ms","start":"2026-06-13T01:03:17.604055Z","end":"2026-06-13T01:03:17.872166Z","steps":["trace[1940184612] 'agreement among raft nodes before linearized reading' (duration: 268.04391ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:19.447136Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.562782919s","expected-duration":"1s"} {"level":"info","ts":"2026-06-13T01:03:19.447496Z","caller":"traceutil/trace.go:171","msg":"trace[508821329] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"1.563234672s","start":"2026-06-13T01:03:17.88424Z","end":"2026-06-13T01:03:19.447475Z","steps":["trace[508821329] 'process raft request' (duration: 1.563073001s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:19.447625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:17.884221Z","time spent":"1.563341002s","remote":"127.0.0.1:46014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-13T01:03:19.503238Z","caller":"traceutil/trace.go:171","msg":"trace[805093969] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"318.062152ms","start":"2026-06-13T01:03:19.185151Z","end":"2026-06-13T01:03:19.503213Z","steps":["trace[805093969] 'process raft request' (duration: 317.919451ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:19.503439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:19.185112Z","time spent":"318.197632ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T01:03:19.712707Z","caller":"traceutil/trace.go:171","msg":"trace[1437815391] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"258.093983ms","start":"2026-06-13T01:03:19.454556Z","end":"2026-06-13T01:03:19.71265Z","steps":["trace[1437815391] 'process raft request' (duration: 257.900182ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:19.712712Z","caller":"traceutil/trace.go:171","msg":"trace[1277000822] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"260.69291ms","start":"2026-06-13T01:03:19.451902Z","end":"2026-06-13T01:03:19.712595Z","steps":["trace[1277000822] 'process raft request' (duration: 260.325138ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:19.712732Z","caller":"traceutil/trace.go:171","msg":"trace[919345898] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"258.135464ms","start":"2026-06-13T01:03:19.454538Z","end":"2026-06-13T01:03:19.712673Z","steps":["trace[919345898] 'process raft request' (duration: 258.015803ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:19.713076Z","caller":"traceutil/trace.go:171","msg":"trace[1292437117] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"257.448769ms","start":"2026-06-13T01:03:19.455604Z","end":"2026-06-13T01:03:19.713053Z","steps":["trace[1292437117] 'process raft request' (duration: 257.012336ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:19.713053Z","caller":"traceutil/trace.go:171","msg":"trace[255844778] linearizableReadLoop","detail":"{readStateIndex:671; appliedIndex:667; }","duration":"174.989283ms","start":"2026-06-13T01:03:19.53798Z","end":"2026-06-13T01:03:19.712969Z","steps":["trace[255844778] 'read index received' (duration: 174.238519ms)","trace[255844778] 'applied index is now lower than readState.Index' (duration: 749.534µs)"],"step_count":2} {"level":"warn","ts":"2026-06-13T01:03:19.713238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.191485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T01:03:19.713447Z","caller":"traceutil/trace.go:171","msg":"trace[987384657] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:643; }","duration":"175.495757ms","start":"2026-06-13T01:03:19.537936Z","end":"2026-06-13T01:03:19.713432Z","steps":["trace[987384657] 'agreement among raft nodes before linearized reading' (duration: 175.189575ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:19.713534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.718487ms","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-06-13T01:03:19.713725Z","caller":"traceutil/trace.go:171","msg":"trace[319974600] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:643; }","duration":"147.940578ms","start":"2026-06-13T01:03:19.565765Z","end":"2026-06-13T01:03:19.713706Z","steps":["trace[319974600] 'agreement among raft nodes before linearized reading' (duration: 147.572836ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:22.574233Z","caller":"traceutil/trace.go:171","msg":"trace[1885134967] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"131.058294ms","start":"2026-06-13T01:03:22.443152Z","end":"2026-06-13T01:03:22.574211Z","steps":["trace[1885134967] 'process raft request' (duration: 131.020084ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:22.574364Z","caller":"traceutil/trace.go:171","msg":"trace[1210430476] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"132.976678ms","start":"2026-06-13T01:03:22.441356Z","end":"2026-06-13T01:03:22.574332Z","steps":["trace[1210430476] 'process raft request' (duration: 132.762845ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:22.574335Z","caller":"traceutil/trace.go:171","msg":"trace[1630260084] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"132.983108ms","start":"2026-06-13T01:03:22.441271Z","end":"2026-06-13T01:03:22.574254Z","steps":["trace[1630260084] 'process raft request' (duration: 132.766966ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:22.859745Z","caller":"traceutil/trace.go:171","msg":"trace[680064746] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"127.992085ms","start":"2026-06-13T01:03:22.731735Z","end":"2026-06-13T01:03:22.859727Z","steps":["trace[680064746] 'process raft request' (duration: 127.871374ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:23.11197Z","caller":"traceutil/trace.go:171","msg":"trace[937621485] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"377.178029ms","start":"2026-06-13T01:03:22.734766Z","end":"2026-06-13T01:03:23.111944Z","steps":["trace[937621485] 'process raft request' (duration: 376.975537ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:23.112143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:22.734746Z","time spent":"377.297929ms","remote":"127.0.0.1:45852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13205,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T01:03:23.112265Z","caller":"traceutil/trace.go:171","msg":"trace[158762313] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"257.147154ms","start":"2026-06-13T01:03:22.85507Z","end":"2026-06-13T01:03:23.112217Z","steps":["trace[158762313] 'process raft request' (duration: 257.046484ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:23.112321Z","caller":"traceutil/trace.go:171","msg":"trace[1446541809] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"325.644962ms","start":"2026-06-13T01:03:22.786665Z","end":"2026-06-13T01:03:23.11231Z","steps":["trace[1446541809] 'process raft request' (duration: 325.228478ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:23.112374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:22.786643Z","time spent":"325.707812ms","remote":"127.0.0.1:45890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":700,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-13T01:03:23.319171Z","caller":"traceutil/trace.go:171","msg":"trace[1190664807] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"104.648112ms","start":"2026-06-13T01:03:23.214499Z","end":"2026-06-13T01:03:23.319147Z","steps":["trace[1190664807] 'process raft request' (duration: 104.478741ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:23.473954Z","caller":"traceutil/trace.go:171","msg":"trace[1786108845] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"196.365304ms","start":"2026-06-13T01:03:23.277559Z","end":"2026-06-13T01:03:23.473924Z","steps":["trace[1786108845] 'process raft request' (duration: 124.599859ms)","trace[1786108845] 'compare' (duration: 71.565874ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:03:23.473971Z","caller":"traceutil/trace.go:171","msg":"trace[291654418] transaction","detail":"{read_only:false; response_revision:689; number_of_response:1; }","duration":"106.457235ms","start":"2026-06-13T01:03:23.36749Z","end":"2026-06-13T01:03:23.473947Z","steps":["trace[291654418] 'process raft request' (duration: 106.412155ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:23.474216Z","caller":"traceutil/trace.go:171","msg":"trace[1565594873] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"148.620131ms","start":"2026-06-13T01:03:23.325586Z","end":"2026-06-13T01:03:23.474206Z","steps":["trace[1565594873] 'process raft request' (duration: 148.272429ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:23.474391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.24171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T01:03:23.474485Z","caller":"traceutil/trace.go:171","msg":"trace[180886433] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:689; }","duration":"156.382321ms","start":"2026-06-13T01:03:23.31808Z","end":"2026-06-13T01:03:23.474462Z","steps":["trace[180886433] 'agreement among raft nodes before linearized reading' (duration: 156.20017ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:23.47509Z","caller":"traceutil/trace.go:171","msg":"trace[1753429082] linearizableReadLoop","detail":"{readStateIndex:716; appliedIndex:713; }","duration":"156.926584ms","start":"2026-06-13T01:03:23.318131Z","end":"2026-06-13T01:03:23.475057Z","steps":["trace[1753429082] 'read index received' (duration: 896.296µs)","trace[1753429082] 'applied index is now lower than readState.Index' (duration: 155.066123ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T01:03:23.475777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.527724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-c222z\" ","response":"range_response_count:1 size:17790"} {"level":"info","ts":"2026-06-13T01:03:23.475831Z","caller":"traceutil/trace.go:171","msg":"trace[1725271473] range","detail":"{range_begin:/registry/pods/kube-system/cilium-c222z; range_end:; response_count:1; response_revision:689; }","duration":"109.717075ms","start":"2026-06-13T01:03:23.366099Z","end":"2026-06-13T01:03:23.475816Z","steps":["trace[1725271473] 'agreement among raft nodes before linearized reading' (duration: 109.436743ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:23.604062Z","caller":"traceutil/trace.go:171","msg":"trace[580184816] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"123.10205ms","start":"2026-06-13T01:03:23.480941Z","end":"2026-06-13T01:03:23.604043Z","steps":["trace[580184816] 'process raft request' (duration: 121.949193ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:23.648508Z","caller":"traceutil/trace.go:171","msg":"trace[1712930768] linearizableReadLoop","detail":"{readStateIndex:721; appliedIndex:718; }","duration":"111.360746ms","start":"2026-06-13T01:03:23.537129Z","end":"2026-06-13T01:03:23.64849Z","steps":["trace[1712930768] 'read index received' (duration: 65.757027ms)","trace[1712930768] 'applied index is now lower than readState.Index' (duration: 45.602609ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:03:23.648707Z","caller":"traceutil/trace.go:171","msg":"trace[1261970511] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"159.747162ms","start":"2026-06-13T01:03:23.488929Z","end":"2026-06-13T01:03:23.648676Z","steps":["trace[1261970511] 'process raft request' (duration: 159.48317ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:23.648819Z","caller":"traceutil/trace.go:171","msg":"trace[361901941] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"166.638656ms","start":"2026-06-13T01:03:23.482159Z","end":"2026-06-13T01:03:23.648798Z","steps":["trace[361901941] 'process raft request' (duration: 166.162543ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:23.64896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.735868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T01:03:23.649083Z","caller":"traceutil/trace.go:171","msg":"trace[1340491348] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:692; }","duration":"111.96974ms","start":"2026-06-13T01:03:23.537089Z","end":"2026-06-13T01:03:23.649059Z","steps":["trace[1340491348] 'agreement among raft nodes before linearized reading' (duration: 111.655808ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:23.764417Z","caller":"traceutil/trace.go:171","msg":"trace[119664356] linearizableReadLoop","detail":"{readStateIndex:722; appliedIndex:721; }","duration":"109.782465ms","start":"2026-06-13T01:03:23.654611Z","end":"2026-06-13T01:03:23.764393Z","steps":["trace[119664356] 'read index received' (duration: 60.498944ms)","trace[119664356] 'applied index is now lower than readState.Index' (duration: 49.282611ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T01:03:23.764543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.913676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-w9nnf\" ","response":"range_response_count:1 size:4683"} {"level":"info","ts":"2026-06-13T01:03:23.764589Z","caller":"traceutil/trace.go:171","msg":"trace[878597868] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-w9nnf; range_end:; response_count:1; response_revision:693; }","duration":"110.012966ms","start":"2026-06-13T01:03:23.654565Z","end":"2026-06-13T01:03:23.764578Z","steps":["trace[878597868] 'agreement among raft nodes before linearized reading' (duration: 109.918596ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:23.764705Z","caller":"traceutil/trace.go:171","msg":"trace[1478508082] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"110.216978ms","start":"2026-06-13T01:03:23.654422Z","end":"2026-06-13T01:03:23.764639Z","steps":["trace[1478508082] 'process raft request' (duration: 60.695195ms)","trace[1478508082] 'compare' (duration: 49.161061ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:03:23.992731Z","caller":"traceutil/trace.go:171","msg":"trace[394585753] linearizableReadLoop","detail":"{readStateIndex:725; appliedIndex:724; }","duration":"122.224264ms","start":"2026-06-13T01:03:23.870481Z","end":"2026-06-13T01:03:23.992705Z","steps":["trace[394585753] 'read index received' (duration: 122.125154ms)","trace[394585753] 'applied index is now lower than readState.Index' (duration: 98.02µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:03:23.992798Z","caller":"traceutil/trace.go:171","msg":"trace[1120753157] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"146.124796ms","start":"2026-06-13T01:03:23.846645Z","end":"2026-06-13T01:03:23.99277Z","steps":["trace[1120753157] 'process raft request' (duration: 145.917624ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:23.992925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.469036ms","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-06-13T01:03:23.992964Z","caller":"traceutil/trace.go:171","msg":"trace[246199468] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:696; }","duration":"122.671998ms","start":"2026-06-13T01:03:23.87028Z","end":"2026-06-13T01:03:23.992952Z","steps":["trace[246199468] 'agreement among raft nodes before linearized reading' (duration: 122.527067ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:24.073275Z","caller":"traceutil/trace.go:171","msg":"trace[313624245] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"164.773981ms","start":"2026-06-13T01:03:23.908475Z","end":"2026-06-13T01:03:24.073249Z","steps":["trace[313624245] 'process raft request' (duration: 164.63571ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:24.120489Z","caller":"traceutil/trace.go:171","msg":"trace[1672795083] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"119.622543ms","start":"2026-06-13T01:03:24.000841Z","end":"2026-06-13T01:03:24.120464Z","steps":["trace[1672795083] 'process raft request' (duration: 119.336871ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:24.120532Z","caller":"traceutil/trace.go:171","msg":"trace[1055791935] linearizableReadLoop","detail":"{readStateIndex:728; appliedIndex:725; }","duration":"113.995708ms","start":"2026-06-13T01:03:24.006515Z","end":"2026-06-13T01:03:24.12051Z","steps":["trace[1055791935] 'read index received' (duration: 66.635941ms)","trace[1055791935] 'applied index is now lower than readState.Index' (duration: 47.357527ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:03:24.120607Z","caller":"traceutil/trace.go:171","msg":"trace[730523852] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"119.678384ms","start":"2026-06-13T01:03:24.00091Z","end":"2026-06-13T01:03:24.120589Z","steps":["trace[730523852] 'process raft request' (duration: 119.402032ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:24.120791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.25107ms","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-06-13T01:03:24.120838Z","caller":"traceutil/trace.go:171","msg":"trace[879998901] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:699; }","duration":"114.331091ms","start":"2026-06-13T01:03:24.006496Z","end":"2026-06-13T01:03:24.120827Z","steps":["trace[879998901] 'agreement among raft nodes before linearized reading' (duration: 114.13157ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:24.120941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.22445ms","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-06-13T01:03:24.120988Z","caller":"traceutil/trace.go:171","msg":"trace[261527546] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:699; }","duration":"114.327881ms","start":"2026-06-13T01:03:24.006649Z","end":"2026-06-13T01:03:24.120977Z","steps":["trace[261527546] 'agreement among raft nodes before linearized reading' (duration: 114.16817ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:24.12101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.526816ms","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-06-13T01:03:24.121038Z","caller":"traceutil/trace.go:171","msg":"trace[410398842] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:699; }","duration":"113.564446ms","start":"2026-06-13T01:03:24.007464Z","end":"2026-06-13T01:03:24.121029Z","steps":["trace[410398842] 'agreement among raft nodes before linearized reading' (duration: 113.480826ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:25.18403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.027623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"info","ts":"2026-06-13T01:03:25.184219Z","caller":"traceutil/trace.go:171","msg":"trace[1767128090] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:708; }","duration":"349.279515ms","start":"2026-06-13T01:03:24.834918Z","end":"2026-06-13T01:03:25.184198Z","steps":["trace[1767128090] 'range keys from in-memory index tree' (duration: 348.846742ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:25.184348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:24.834892Z","time spent":"349.442866ms","remote":"127.0.0.1:45852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":1,"response size":10400,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" "} {"level":"info","ts":"2026-06-13T01:03:25.231742Z","caller":"traceutil/trace.go:171","msg":"trace[737201716] transaction","detail":"{read_only:false; response_revision:709; number_of_response:1; }","duration":"194.576709ms","start":"2026-06-13T01:03:25.037144Z","end":"2026-06-13T01:03:25.231721Z","steps":["trace[737201716] 'process raft request' (duration: 194.457599ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:25.34843Z","caller":"traceutil/trace.go:171","msg":"trace[1521862747] transaction","detail":"{read_only:false; response_revision:710; number_of_response:1; }","duration":"111.323488ms","start":"2026-06-13T01:03:25.237079Z","end":"2026-06-13T01:03:25.348403Z","steps":["trace[1521862747] 'process raft request' (duration: 65.52562ms)","trace[1521862747] 'compare' (duration: 45.678277ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:03:25.459086Z","caller":"traceutil/trace.go:171","msg":"trace[1343764229] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"104.023282ms","start":"2026-06-13T01:03:25.355025Z","end":"2026-06-13T01:03:25.459049Z","steps":["trace[1343764229] 'process raft request' (duration: 95.294027ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:25.946329Z","caller":"traceutil/trace.go:171","msg":"trace[1051510990] linearizableReadLoop","detail":"{readStateIndex:745; appliedIndex:744; }","duration":"111.669141ms","start":"2026-06-13T01:03:25.834641Z","end":"2026-06-13T01:03:25.94631Z","steps":["trace[1051510990] 'read index received' (duration: 111.49263ms)","trace[1051510990] 'applied index is now lower than readState.Index' (duration: 175.481µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:03:25.946384Z","caller":"traceutil/trace.go:171","msg":"trace[1202824174] transaction","detail":"{read_only:false; response_revision:716; number_of_response:1; }","duration":"156.132048ms","start":"2026-06-13T01:03:25.790224Z","end":"2026-06-13T01:03:25.946356Z","steps":["trace[1202824174] 'process raft request' (duration: 155.948217ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:25.946518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.863932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:1 size:4333"} {"level":"info","ts":"2026-06-13T01:03:25.946589Z","caller":"traceutil/trace.go:171","msg":"trace[2050916250] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:1; response_revision:716; }","duration":"111.988992ms","start":"2026-06-13T01:03:25.834586Z","end":"2026-06-13T01:03:25.946575Z","steps":["trace[2050916250] 'agreement among raft nodes before linearized reading' (duration: 111.807171ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:26.054076Z","caller":"traceutil/trace.go:171","msg":"trace[1264971258] transaction","detail":"{read_only:false; response_revision:717; number_of_response:1; }","duration":"148.434999ms","start":"2026-06-13T01:03:25.905625Z","end":"2026-06-13T01:03:26.05406Z","steps":["trace[1264971258] 'process raft request' (duration: 148.130907ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:26.272418Z","caller":"traceutil/trace.go:171","msg":"trace[2119728073] linearizableReadLoop","detail":"{readStateIndex:748; appliedIndex:747; }","duration":"147.116248ms","start":"2026-06-13T01:03:26.12528Z","end":"2026-06-13T01:03:26.272396Z","steps":["trace[2119728073] 'read index received' (duration: 139.145268ms)","trace[2119728073] 'applied index is now lower than readState.Index' (duration: 7.96957ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:03:26.272573Z","caller":"traceutil/trace.go:171","msg":"trace[497030808] transaction","detail":"{read_only:false; response_revision:719; number_of_response:1; }","duration":"170.155112ms","start":"2026-06-13T01:03:26.102402Z","end":"2026-06-13T01:03:26.272557Z","steps":["trace[497030808] 'process raft request' (duration: 162.036721ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:26.272868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.57862ms","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-06-13T01:03:26.27291Z","caller":"traceutil/trace.go:171","msg":"trace[924246943] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:719; }","duration":"147.675682ms","start":"2026-06-13T01:03:26.125224Z","end":"2026-06-13T01:03:26.2729Z","steps":["trace[924246943] 'agreement among raft nodes before linearized reading' (duration: 147.491741ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:26.34745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.929524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-13T01:03:26.347537Z","caller":"traceutil/trace.go:171","msg":"trace[1421758665] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:720; }","duration":"206.069944ms","start":"2026-06-13T01:03:26.141453Z","end":"2026-06-13T01:03:26.347523Z","steps":["trace[1421758665] 'agreement among raft nodes before linearized reading' (duration: 205.816003ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:26.347969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.906183ms","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-06-13T01:03:26.348027Z","caller":"traceutil/trace.go:171","msg":"trace[1272903844] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:720; }","duration":"201.000593ms","start":"2026-06-13T01:03:26.147013Z","end":"2026-06-13T01:03:26.348014Z","steps":["trace[1272903844] 'agreement among raft nodes before linearized reading' (duration: 200.831702ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:26.348284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.423569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.227\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-13T01:03:26.34835Z","caller":"traceutil/trace.go:171","msg":"trace[619914958] range","detail":"{range_begin:/registry/masterleases/199.204.45.227; range_end:; response_count:1; response_revision:720; }","duration":"158.553389ms","start":"2026-06-13T01:03:26.189783Z","end":"2026-06-13T01:03:26.348336Z","steps":["trace[619914958] 'agreement among raft nodes before linearized reading' (duration: 158.241927ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:26.348693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.07212ms","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-06-13T01:03:26.348726Z","caller":"traceutil/trace.go:171","msg":"trace[1024573676] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:720; }","duration":"202.1485ms","start":"2026-06-13T01:03:26.146571Z","end":"2026-06-13T01:03:26.348719Z","steps":["trace[1024573676] 'agreement among raft nodes before linearized reading' (duration: 201.437826ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:26.429677Z","caller":"traceutil/trace.go:171","msg":"trace[152246333] transaction","detail":"{read_only:false; response_revision:721; number_of_response:1; }","duration":"151.711796ms","start":"2026-06-13T01:03:26.277943Z","end":"2026-06-13T01:03:26.429655Z","steps":["trace[152246333] 'process raft request' (duration: 151.431334ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:26.430083Z","caller":"traceutil/trace.go:171","msg":"trace[319678054] transaction","detail":"{read_only:false; response_revision:722; number_of_response:1; }","duration":"105.303007ms","start":"2026-06-13T01:03:26.324763Z","end":"2026-06-13T01:03:26.430066Z","steps":["trace[319678054] 'process raft request' (duration: 104.820434ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:26.483534Z","caller":"traceutil/trace.go:171","msg":"trace[1114770638] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"124.432306ms","start":"2026-06-13T01:03:26.359076Z","end":"2026-06-13T01:03:26.483508Z","steps":["trace[1114770638] 'process raft request' (duration: 124.251485ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:26.483857Z","caller":"traceutil/trace.go:171","msg":"trace[1983018688] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"124.749298ms","start":"2026-06-13T01:03:26.359084Z","end":"2026-06-13T01:03:26.483833Z","steps":["trace[1983018688] 'process raft request' (duration: 124.383096ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:26.484369Z","caller":"traceutil/trace.go:171","msg":"trace[630161009] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"123.569421ms","start":"2026-06-13T01:03:26.360782Z","end":"2026-06-13T01:03:26.484352Z","steps":["trace[630161009] 'process raft request' (duration: 123.36459ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:26.484549Z","caller":"traceutil/trace.go:171","msg":"trace[551110579] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"124.229384ms","start":"2026-06-13T01:03:26.3603Z","end":"2026-06-13T01:03:26.484529Z","steps":["trace[551110579] 'process raft request' (duration: 123.59556ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:32.650745Z","caller":"traceutil/trace.go:171","msg":"trace[1845677636] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"188.010061ms","start":"2026-06-13T01:03:32.462704Z","end":"2026-06-13T01:03:32.650714Z","steps":["trace[1845677636] 'process raft request' (duration: 187.8479ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:32.650968Z","caller":"traceutil/trace.go:171","msg":"trace[1654220250] linearizableReadLoop","detail":"{readStateIndex:811; appliedIndex:811; }","duration":"135.767144ms","start":"2026-06-13T01:03:32.515173Z","end":"2026-06-13T01:03:32.65094Z","steps":["trace[1654220250] 'read index received' (duration: 135.756204ms)","trace[1654220250] 'applied index is now lower than readState.Index' (duration: 8.6µs)"],"step_count":2} {"level":"warn","ts":"2026-06-13T01:03:32.651412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.399181ms","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-06-13T01:03:32.65142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.170713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T01:03:32.651523Z","caller":"traceutil/trace.go:171","msg":"trace[808469904] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:780; }","duration":"114.324234ms","start":"2026-06-13T01:03:32.537184Z","end":"2026-06-13T01:03:32.651508Z","steps":["trace[808469904] 'agreement among raft nodes before linearized reading' (duration: 114.135533ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:32.651465Z","caller":"traceutil/trace.go:171","msg":"trace[1490992156] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:780; }","duration":"135.488653ms","start":"2026-06-13T01:03:32.51596Z","end":"2026-06-13T01:03:32.651449Z","steps":["trace[1490992156] 'agreement among raft nodes before linearized reading' (duration: 135.324672ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:32.651866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.917505ms","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-06-13T01:03:32.651903Z","caller":"traceutil/trace.go:171","msg":"trace[1573194038] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:780; }","duration":"135.988945ms","start":"2026-06-13T01:03:32.515905Z","end":"2026-06-13T01:03:32.651894Z","steps":["trace[1573194038] 'agreement among raft nodes before linearized reading' (duration: 135.234251ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:32.652305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.580138ms","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-06-13T01:03:32.652401Z","caller":"traceutil/trace.go:171","msg":"trace[1984798189] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:780; }","duration":"137.271533ms","start":"2026-06-13T01:03:32.515113Z","end":"2026-06-13T01:03:32.652385Z","steps":["trace[1984798189] 'agreement among raft nodes before linearized reading' (duration: 135.917625ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:35.83436Z","caller":"traceutil/trace.go:171","msg":"trace[378548774] linearizableReadLoop","detail":"{readStateIndex:831; appliedIndex:830; }","duration":"296.184055ms","start":"2026-06-13T01:03:35.538145Z","end":"2026-06-13T01:03:35.834329Z","steps":["trace[378548774] 'read index received' (duration: 295.923544ms)","trace[378548774] 'applied index is now lower than readState.Index' (duration: 259.171µs)"],"step_count":2} {"level":"warn","ts":"2026-06-13T01:03:35.834747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.386706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T01:03:35.834642Z","caller":"traceutil/trace.go:171","msg":"trace[2033141901] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"384.698035ms","start":"2026-06-13T01:03:35.449902Z","end":"2026-06-13T01:03:35.8346Z","steps":["trace[2033141901] 'process raft request' (duration: 384.077591ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:35.834801Z","caller":"traceutil/trace.go:171","msg":"trace[1196350812] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:799; }","duration":"296.710988ms","start":"2026-06-13T01:03:35.538078Z","end":"2026-06-13T01:03:35.834789Z","steps":["trace[1196350812] 'agreement among raft nodes before linearized reading' (duration: 296.372446ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:35.83509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:03:35.449861Z","time spent":"385.113437ms","remote":"127.0.0.1:46068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T01:03:48.834294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.676263ms","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-06-13T01:03:48.834387Z","caller":"traceutil/trace.go:171","msg":"trace[1366338093] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:950; }","duration":"105.814389ms","start":"2026-06-13T01:03:48.728544Z","end":"2026-06-13T01:03:48.834358Z","steps":["trace[1366338093] 'range keys from in-memory index tree' (duration: 105.475515ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:48.834783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.598813ms","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-06-13T01:03:48.834966Z","caller":"traceutil/trace.go:171","msg":"trace[973597663] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:950; }","duration":"101.836061ms","start":"2026-06-13T01:03:48.733098Z","end":"2026-06-13T01:03:48.834934Z","steps":["trace[973597663] 'range keys from in-memory index tree' (duration: 101.2401ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:03:48.834996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.933138ms","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-06-13T01:03:48.835049Z","caller":"traceutil/trace.go:171","msg":"trace[564850924] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:950; }","duration":"118.039692ms","start":"2026-06-13T01:03:48.716996Z","end":"2026-06-13T01:03:48.835036Z","steps":["trace[564850924] 'range keys from in-memory index tree' (duration: 117.771552ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:58.543566Z","caller":"traceutil/trace.go:171","msg":"trace[479806375] transaction","detail":"{read_only:false; response_revision:1160; number_of_response:1; }","duration":"244.991123ms","start":"2026-06-13T01:03:58.298542Z","end":"2026-06-13T01:03:58.543533Z","steps":["trace[479806375] 'process raft request' (duration: 185.897429ms)","trace[479806375] 'compare' (duration: 58.948689ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:03:58.573611Z","caller":"traceutil/trace.go:171","msg":"trace[86441931] transaction","detail":"{read_only:false; response_revision:1161; number_of_response:1; }","duration":"205.776725ms","start":"2026-06-13T01:03:58.367812Z","end":"2026-06-13T01:03:58.573588Z","steps":["trace[86441931] 'process raft request' (duration: 205.60917ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:58.573826Z","caller":"traceutil/trace.go:171","msg":"trace[223956889] transaction","detail":"{read_only:false; response_revision:1162; number_of_response:1; }","duration":"205.620461ms","start":"2026-06-13T01:03:58.368161Z","end":"2026-06-13T01:03:58.573782Z","steps":["trace[223956889] 'process raft request' (duration: 205.377993ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:03:58.89937Z","caller":"traceutil/trace.go:171","msg":"trace[474159027] transaction","detail":"{read_only:false; response_revision:1164; number_of_response:1; }","duration":"219.888442ms","start":"2026-06-13T01:03:58.679451Z","end":"2026-06-13T01:03:58.89934Z","steps":["trace[474159027] 'process raft request' (duration: 218.189716ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:04:00.717423Z","caller":"traceutil/trace.go:171","msg":"trace[264160692] transaction","detail":"{read_only:false; response_revision:1176; number_of_response:1; }","duration":"104.989434ms","start":"2026-06-13T01:04:00.612407Z","end":"2026-06-13T01:04:00.717396Z","steps":["trace[264160692] 'process raft request' (duration: 68.65339ms)","trace[264160692] 'compare' (duration: 36.229141ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T01:04:23.286915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.243143ms","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-06-13T01:04:23.286997Z","caller":"traceutil/trace.go:171","msg":"trace[795263188] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1340; }","duration":"196.381307ms","start":"2026-06-13T01:04:23.090599Z","end":"2026-06-13T01:04:23.28698Z","steps":["trace[795263188] 'count revisions from in-memory index tree' (duration: 196.169822ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:04:23.287185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.14744ms","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-06-13T01:04:23.287248Z","caller":"traceutil/trace.go:171","msg":"trace[1539957627] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1340; }","duration":"147.250563ms","start":"2026-06-13T01:04:23.139978Z","end":"2026-06-13T01:04:23.287228Z","steps":["trace[1539957627] 'range keys from in-memory index tree' (duration: 146.932173ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:04:23.288097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.60264ms","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-06-13T01:04:23.288265Z","caller":"traceutil/trace.go:171","msg":"trace[1403383795] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1340; }","duration":"170.684186ms","start":"2026-06-13T01:04:23.117552Z","end":"2026-06-13T01:04:23.288236Z","steps":["trace[1403383795] 'range keys from in-memory index tree' (duration: 169.218359ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:04:23.288518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.752006ms","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-06-13T01:04:23.288638Z","caller":"traceutil/trace.go:171","msg":"trace[1147244168] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1340; }","duration":"134.922401ms","start":"2026-06-13T01:04:23.153691Z","end":"2026-06-13T01:04:23.288613Z","steps":["trace[1147244168] 'range keys from in-memory index tree' (duration: 133.221968ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:04:23.288933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.811668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-13T01:04:23.289009Z","caller":"traceutil/trace.go:171","msg":"trace[409907732] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1340; }","duration":"136.917471ms","start":"2026-06-13T01:04:23.152078Z","end":"2026-06-13T01:04:23.288995Z","steps":["trace[409907732] 'range keys from in-memory index tree' (duration: 136.622254ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:04:23.289228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.431677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-13T01:04:23.289272Z","caller":"traceutil/trace.go:171","msg":"trace[1615371168] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1340; }","duration":"145.493938ms","start":"2026-06-13T01:04:23.143768Z","end":"2026-06-13T01:04:23.289262Z","steps":["trace[1615371168] 'range keys from in-memory index tree' (duration: 143.175279ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:04:28.787283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.041668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T01:04:28.787429Z","caller":"traceutil/trace.go:171","msg":"trace[322728093] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1455; }","duration":"251.254103ms","start":"2026-06-13T01:04:28.536151Z","end":"2026-06-13T01:04:28.787405Z","steps":["trace[322728093] 'range keys from in-memory index tree' (duration: 250.913214ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:04:28.821848Z","caller":"traceutil/trace.go:171","msg":"trace[508556286] transaction","detail":"{read_only:false; response_revision:1456; number_of_response:1; }","duration":"118.352737ms","start":"2026-06-13T01:04:28.703455Z","end":"2026-06-13T01:04:28.821808Z","steps":["trace[508556286] 'process raft request' (duration: 118.040929ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:04:31.083538Z","caller":"traceutil/trace.go:171","msg":"trace[238525354] linearizableReadLoop","detail":"{readStateIndex:1517; appliedIndex:1516; }","duration":"185.293139ms","start":"2026-06-13T01:04:30.898218Z","end":"2026-06-13T01:04:31.083511Z","steps":["trace[238525354] 'read index received' (duration: 185.089944ms)","trace[238525354] 'applied index is now lower than readState.Index' (duration: 201.905µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:04:31.0836Z","caller":"traceutil/trace.go:171","msg":"trace[570136881] transaction","detail":"{read_only:false; response_revision:1467; number_of_response:1; }","duration":"251.854345ms","start":"2026-06-13T01:04:30.831709Z","end":"2026-06-13T01:04:31.083563Z","steps":["trace[570136881] 'process raft request' (duration: 251.65135ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:04:31.083691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.442662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-13T01:04:31.083762Z","caller":"traceutil/trace.go:171","msg":"trace[1725694531] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1467; }","duration":"185.541824ms","start":"2026-06-13T01:04:30.898209Z","end":"2026-06-13T01:04:31.083751Z","steps":["trace[1725694531] 'agreement among raft nodes before linearized reading' (duration: 185.401881ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:04:31.476609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.604859ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-13T01:04:31.476774Z","caller":"traceutil/trace.go:171","msg":"trace[1329018056] linearizableReadLoop","detail":"{readStateIndex:1518; appliedIndex:1517; }","duration":"133.854938ms","start":"2026-06-13T01:04:31.342892Z","end":"2026-06-13T01:04:31.476747Z","steps":["trace[1329018056] 'read index received' (duration: 62.292µs)","trace[1329018056] 'applied index is now lower than readState.Index' (duration: 133.790536ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T01:04:31.477057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.148125ms","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-06-13T01:04:31.477196Z","caller":"traceutil/trace.go:171","msg":"trace[134260280] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1467; }","duration":"134.33563ms","start":"2026-06-13T01:04:31.342836Z","end":"2026-06-13T01:04:31.477172Z","steps":["trace[134260280] 'agreement among raft nodes before linearized reading' (duration: 134.031832ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:04:31.477242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.611871ms","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-06-13T01:04:31.477289Z","caller":"traceutil/trace.go:171","msg":"trace[2057768075] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1467; }","duration":"118.671263ms","start":"2026-06-13T01:04:31.358602Z","end":"2026-06-13T01:04:31.477274Z","steps":["trace[2057768075] 'agreement among raft nodes before linearized reading' (duration: 118.563651ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:04:31.477129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.595581ms","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-06-13T01:04:31.477334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.048545ms","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-06-13T01:04:31.477546Z","caller":"traceutil/trace.go:171","msg":"trace[663428314] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1467; }","duration":"122.076882ms","start":"2026-06-13T01:04:31.355459Z","end":"2026-06-13T01:04:31.477536Z","steps":["trace[663428314] 'agreement among raft nodes before linearized reading' (duration: 121.467597ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:04:31.477569Z","caller":"traceutil/trace.go:171","msg":"trace[937820297] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1467; }","duration":"120.289431ms","start":"2026-06-13T01:04:31.357258Z","end":"2026-06-13T01:04:31.477548Z","steps":["trace[937820297] 'agreement among raft nodes before linearized reading' (duration: 119.919492ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:04:31.477633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.042689ms","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-06-13T01:04:31.477728Z","caller":"traceutil/trace.go:171","msg":"trace[2067853094] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1467; }","duration":"121.204542ms","start":"2026-06-13T01:04:31.356505Z","end":"2026-06-13T01:04:31.47771Z","steps":["trace[2067853094] 'agreement among raft nodes before linearized reading' (duration: 120.6845ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:04:31.636189Z","caller":"traceutil/trace.go:171","msg":"trace[207070613] transaction","detail":"{read_only:false; response_revision:1469; number_of_response:1; }","duration":"152.935365ms","start":"2026-06-13T01:04:31.483225Z","end":"2026-06-13T01:04:31.63616Z","steps":["trace[207070613] 'process raft request' (duration: 152.622148ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:04:31.636541Z","caller":"traceutil/trace.go:171","msg":"trace[903883266] transaction","detail":"{read_only:false; response_revision:1470; number_of_response:1; }","duration":"153.252833ms","start":"2026-06-13T01:04:31.483238Z","end":"2026-06-13T01:04:31.636491Z","steps":["trace[903883266] 'process raft request' (duration: 152.873274ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:04:31.636618Z","caller":"traceutil/trace.go:171","msg":"trace[850863194] transaction","detail":"{read_only:false; response_revision:1473; number_of_response:1; }","duration":"106.280111ms","start":"2026-06-13T01:04:31.530313Z","end":"2026-06-13T01:04:31.636593Z","steps":["trace[850863194] 'process raft request' (duration: 106.191939ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:04:31.636738Z","caller":"traceutil/trace.go:171","msg":"trace[1535326885] transaction","detail":"{read_only:false; response_revision:1471; number_of_response:1; }","duration":"153.037669ms","start":"2026-06-13T01:04:31.483689Z","end":"2026-06-13T01:04:31.636727Z","steps":["trace[1535326885] 'process raft request' (duration: 152.655719ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:04:31.636798Z","caller":"traceutil/trace.go:171","msg":"trace[1452211521] transaction","detail":"{read_only:false; response_revision:1472; number_of_response:1; }","duration":"144.256623ms","start":"2026-06-13T01:04:31.492532Z","end":"2026-06-13T01:04:31.636789Z","steps":["trace[1452211521] 'process raft request' (duration: 143.937925ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:04:49.82411Z","caller":"traceutil/trace.go:171","msg":"trace[118287326] linearizableReadLoop","detail":"{readStateIndex:1851; appliedIndex:1850; }","duration":"164.103536ms","start":"2026-06-13T01:04:49.659979Z","end":"2026-06-13T01:04:49.824083Z","steps":["trace[118287326] 'read index received' (duration: 163.021083ms)","trace[118287326] 'applied index is now lower than readState.Index' (duration: 1.080733ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:04:49.824325Z","caller":"traceutil/trace.go:171","msg":"trace[257916454] transaction","detail":"{read_only:false; response_revision:1775; number_of_response:1; }","duration":"201.439941ms","start":"2026-06-13T01:04:49.622849Z","end":"2026-06-13T01:04:49.824289Z","steps":["trace[257916454] 'process raft request' (duration: 200.231166ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:04:49.824674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.676088ms","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-06-13T01:04:49.824744Z","caller":"traceutil/trace.go:171","msg":"trace[1662955682] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1775; }","duration":"164.757729ms","start":"2026-06-13T01:04:49.659966Z","end":"2026-06-13T01:04:49.824724Z","steps":["trace[1662955682] 'agreement among raft nodes before linearized reading' (duration: 164.30652ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:04:50.12068Z","caller":"traceutil/trace.go:171","msg":"trace[213578173] transaction","detail":"{read_only:false; response_revision:1781; number_of_response:1; }","duration":"175.013075ms","start":"2026-06-13T01:04:49.945644Z","end":"2026-06-13T01:04:50.120657Z","steps":["trace[213578173] 'process raft request' (duration: 174.857021ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:04:50.471631Z","caller":"traceutil/trace.go:171","msg":"trace[1062462334] transaction","detail":"{read_only:false; response_revision:1782; number_of_response:1; }","duration":"206.332405ms","start":"2026-06-13T01:04:50.265268Z","end":"2026-06-13T01:04:50.4716Z","steps":["trace[1062462334] 'process raft request' (duration: 206.115691ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:04:59.790281Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656053326625019930,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-13T01:05:00.278826Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.059510038s","expected-duration":"1s"} {"level":"info","ts":"2026-06-13T01:05:00.27927Z","caller":"traceutil/trace.go:171","msg":"trace[440816619] linearizableReadLoop","detail":"{readStateIndex:1978; appliedIndex:1977; }","duration":"989.286245ms","start":"2026-06-13T01:04:59.289964Z","end":"2026-06-13T01:05:00.279251Z","steps":["trace[440816619] 'read index received' (duration: 989.066161ms)","trace[440816619] 'applied index is now lower than readState.Index' (duration: 218.914µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:05:00.279329Z","caller":"traceutil/trace.go:171","msg":"trace[1994829655] transaction","detail":"{read_only:false; response_revision:1900; number_of_response:1; }","duration":"1.063696405s","start":"2026-06-13T01:04:59.215593Z","end":"2026-06-13T01:05:00.27929Z","steps":["trace[1994829655] 'process raft request' (duration: 1.06342495s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:00.279489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"989.509739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-90e5ef6d-5eb0-4609-9516-8b1b5c706e78\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-13T01:05:00.279512Z","caller":"traceutil/trace.go:171","msg":"trace[1237624982] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-90e5ef6d-5eb0-4609-9516-8b1b5c706e78; range_end:; response_count:1; response_revision:1900; }","duration":"989.616191ms","start":"2026-06-13T01:04:59.289889Z","end":"2026-06-13T01:05:00.279505Z","steps":["trace[1237624982] 'agreement among raft nodes before linearized reading' (duration: 989.489499ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:00.279558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:04:59.289864Z","time spent":"989.686332ms","remote":"127.0.0.1:46014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-90e5ef6d-5eb0-4609-9516-8b1b5c706e78\" "} {"level":"warn","ts":"2026-06-13T01:05:00.279567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:04:59.215565Z","time spent":"1.063871119s","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T01:05:00.352417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.615682ms","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-06-13T01:05:00.352443Z","caller":"traceutil/trace.go:171","msg":"trace[1162660220] transaction","detail":"{read_only:false; response_revision:1901; number_of_response:1; }","duration":"188.917671ms","start":"2026-06-13T01:05:00.1635Z","end":"2026-06-13T01:05:00.352417Z","steps":["trace[1162660220] 'process raft request' (duration: 179.147773ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:00.352467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.451959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-90e5ef6d-5eb0-4609-9516-8b1b5c706e78\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-13T01:05:00.352482Z","caller":"traceutil/trace.go:171","msg":"trace[1038557119] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1901; }","duration":"434.756205ms","start":"2026-06-13T01:04:59.917709Z","end":"2026-06-13T01:05:00.352465Z","steps":["trace[1038557119] 'agreement among raft nodes before linearized reading' (duration: 434.51524ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:05:00.352526Z","caller":"traceutil/trace.go:171","msg":"trace[1832658351] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-90e5ef6d-5eb0-4609-9516-8b1b5c706e78; range_end:; response_count:1; response_revision:1901; }","duration":"459.557461ms","start":"2026-06-13T01:04:59.89295Z","end":"2026-06-13T01:05:00.352508Z","steps":["trace[1832658351] 'agreement among raft nodes before linearized reading' (duration: 459.389458ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:00.352553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.479725ms","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-06-13T01:05:00.352629Z","caller":"traceutil/trace.go:171","msg":"trace[1745841100] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1901; }","duration":"475.598217ms","start":"2026-06-13T01:04:59.877013Z","end":"2026-06-13T01:05:00.352611Z","steps":["trace[1745841100] 'agreement among raft nodes before linearized reading' (duration: 475.376333ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:00.352526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:04:59.917678Z","time spent":"434.839186ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-13T01:05:00.35268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:04:59.876933Z","time spent":"475.738959ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-13T01:05:00.352604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:04:59.892925Z","time spent":"459.628883ms","remote":"127.0.0.1:46014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-90e5ef6d-5eb0-4609-9516-8b1b5c706e78\" "} {"level":"warn","ts":"2026-06-13T01:05:00.3528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.11773ms","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":"warn","ts":"2026-06-13T01:05:00.352883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.60391ms","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-06-13T01:05:00.352875Z","caller":"traceutil/trace.go:171","msg":"trace[2128282208] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1901; }","duration":"203.233713ms","start":"2026-06-13T01:05:00.149629Z","end":"2026-06-13T01:05:00.352863Z","steps":["trace[2128282208] 'agreement among raft nodes before linearized reading' (duration: 203.06698ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:05:00.352934Z","caller":"traceutil/trace.go:171","msg":"trace[1014571090] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1901; }","duration":"435.686832ms","start":"2026-06-13T01:04:59.917235Z","end":"2026-06-13T01:05:00.352922Z","steps":["trace[1014571090] 'agreement among raft nodes before linearized reading' (duration: 435.05007ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:00.352978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:04:59.917222Z","time spent":"435.747973ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-13T01:05:00.353074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.429169ms","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-06-13T01:05:00.353177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"814.884323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T01:05:00.353309Z","caller":"traceutil/trace.go:171","msg":"trace[1173944747] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1901; }","duration":"815.067586ms","start":"2026-06-13T01:04:59.538225Z","end":"2026-06-13T01:05:00.353293Z","steps":["trace[1173944747] 'agreement among raft nodes before linearized reading' (duration: 813.960477ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:00.353423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:04:59.538196Z","time spent":"815.21478ms","remote":"127.0.0.1:45800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-13T01:05:00.353478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.188915ms","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-06-13T01:05:00.353195Z","caller":"traceutil/trace.go:171","msg":"trace[245032470] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1901; }","duration":"433.747005ms","start":"2026-06-13T01:04:59.919424Z","end":"2026-06-13T01:05:00.353171Z","steps":["trace[245032470] 'agreement among raft nodes before linearized reading' (duration: 433.331748ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:00.353663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:04:59.919404Z","time spent":"434.244875ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-13T01:05:00.353752Z","caller":"traceutil/trace.go:171","msg":"trace[1035828963] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1901; }","duration":"439.436991ms","start":"2026-06-13T01:04:59.914179Z","end":"2026-06-13T01:05:00.353616Z","steps":["trace[1035828963] 'agreement among raft nodes before linearized reading' (duration: 438.075726ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:00.353919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:04:59.914168Z","time spent":"439.699366ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-13T01:05:00.616182Z","caller":"traceutil/trace.go:171","msg":"trace[1867316186] transaction","detail":"{read_only:false; response_revision:1903; number_of_response:1; }","duration":"257.556086ms","start":"2026-06-13T01:05:00.358595Z","end":"2026-06-13T01:05:00.616151Z","steps":["trace[1867316186] 'process raft request' (duration: 257.190669ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:05:00.616167Z","caller":"traceutil/trace.go:171","msg":"trace[168229607] transaction","detail":"{read_only:false; response_revision:1904; number_of_response:1; }","duration":"257.415643ms","start":"2026-06-13T01:05:00.358707Z","end":"2026-06-13T01:05:00.616122Z","steps":["trace[168229607] 'process raft request' (duration: 257.317031ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:05:00.616377Z","caller":"traceutil/trace.go:171","msg":"trace[714854980] transaction","detail":"{read_only:false; response_revision:1905; number_of_response:1; }","duration":"256.892362ms","start":"2026-06-13T01:05:00.359471Z","end":"2026-06-13T01:05:00.616364Z","steps":["trace[714854980] 'process raft request' (duration: 256.602017ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:05:00.616731Z","caller":"traceutil/trace.go:171","msg":"trace[964393223] transaction","detail":"{read_only:false; response_revision:1906; number_of_response:1; }","duration":"256.079918ms","start":"2026-06-13T01:05:00.360635Z","end":"2026-06-13T01:05:00.616715Z","steps":["trace[964393223] 'process raft request' (duration: 255.6646ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:05:00.616758Z","caller":"traceutil/trace.go:171","msg":"trace[1195077876] transaction","detail":"{read_only:false; response_revision:1907; number_of_response:1; }","duration":"255.149961ms","start":"2026-06-13T01:05:00.361583Z","end":"2026-06-13T01:05:00.616733Z","steps":["trace[1195077876] 'process raft request' (duration: 254.947357ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:05:00.625653Z","caller":"traceutil/trace.go:171","msg":"trace[1662304808] transaction","detail":"{read_only:false; response_revision:1908; number_of_response:1; }","duration":"122.670041ms","start":"2026-06-13T01:05:00.502956Z","end":"2026-06-13T01:05:00.625626Z","steps":["trace[1662304808] 'process raft request' (duration: 122.205112ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:05:06.414136Z","caller":"traceutil/trace.go:171","msg":"trace[1320746209] transaction","detail":"{read_only:false; response_revision:1955; number_of_response:1; }","duration":"110.954248ms","start":"2026-06-13T01:05:06.303157Z","end":"2026-06-13T01:05:06.414111Z","steps":["trace[1320746209] 'process raft request' (duration: 110.787255ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:15.03941Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656053326625020184,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-13T01:05:15.226289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.919195ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T01:05:15.226696Z","caller":"traceutil/trace.go:171","msg":"trace[54908432] transaction","detail":"{read_only:false; response_revision:2025; number_of_response:1; }","duration":"688.859631ms","start":"2026-06-13T01:05:14.537775Z","end":"2026-06-13T01:05:15.226635Z","steps":["trace[54908432] 'process raft request' (duration: 556.717985ms)","trace[54908432] 'compare' (duration: 130.756962ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T01:05:15.22695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"687.851623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T01:05:15.226712Z","caller":"traceutil/trace.go:171","msg":"trace[956443523] linearizableReadLoop","detail":"{readStateIndex:2109; appliedIndex:2106; }","duration":"687.6082ms","start":"2026-06-13T01:05:14.539086Z","end":"2026-06-13T01:05:15.226694Z","steps":["trace[956443523] 'read index received' (duration: 555.429804ms)","trace[956443523] 'applied index is now lower than readState.Index' (duration: 132.177106ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:05:15.226951Z","caller":"traceutil/trace.go:171","msg":"trace[1663795489] transaction","detail":"{read_only:false; response_revision:2027; number_of_response:1; }","duration":"495.210066ms","start":"2026-06-13T01:05:14.731693Z","end":"2026-06-13T01:05:15.226903Z","steps":["trace[1663795489] 'process raft request' (duration: 494.946752ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:05:15.22702Z","caller":"traceutil/trace.go:171","msg":"trace[267984823] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2027; }","duration":"687.952176ms","start":"2026-06-13T01:05:14.539051Z","end":"2026-06-13T01:05:15.227003Z","steps":["trace[267984823] 'agreement among raft nodes before linearized reading' (duration: 687.693981ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:15.226981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:05:14.537765Z","time spent":"689.090934ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T01:05:15.227065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:05:14.539031Z","time spent":"688.025796ms","remote":"127.0.0.1:45800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-13T01:05:15.226935Z","caller":"traceutil/trace.go:171","msg":"trace[772042676] transaction","detail":"{read_only:false; response_revision:2026; number_of_response:1; }","duration":"495.292266ms","start":"2026-06-13T01:05:14.731579Z","end":"2026-06-13T01:05:15.226871Z","steps":["trace[772042676] 'process raft request' (duration: 494.89588ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:15.22743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:05:14.731544Z","time spent":"495.790825ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T01:05:15.227183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:05:14.731646Z","time spent":"495.403078ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T01:05:15.228015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.846379ms","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-06-13T01:05:15.228108Z","caller":"traceutil/trace.go:171","msg":"trace[299336293] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2027; }","duration":"475.024912ms","start":"2026-06-13T01:05:14.753058Z","end":"2026-06-13T01:05:15.228083Z","steps":["trace[299336293] 'agreement among raft nodes before linearized reading' (duration: 474.350531ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:15.228168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:05:14.753049Z","time spent":"475.103063ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-13T01:05:15.228284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.916006ms","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-06-13T01:05:15.228375Z","caller":"traceutil/trace.go:171","msg":"trace[2068304637] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2027; }","duration":"482.081168ms","start":"2026-06-13T01:05:14.746277Z","end":"2026-06-13T01:05:15.228358Z","steps":["trace[2068304637] 'agreement among raft nodes before linearized reading' (duration: 481.202864ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:15.228413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:05:14.746254Z","time spent":"482.150889ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-13T01:05:15.228393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.960841ms","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-06-13T01:05:15.228472Z","caller":"traceutil/trace.go:171","msg":"trace[1357284641] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2027; }","duration":"489.058773ms","start":"2026-06-13T01:05:14.739395Z","end":"2026-06-13T01:05:15.228454Z","steps":["trace[1357284641] 'agreement among raft nodes before linearized reading' (duration: 488.112628ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:15.228566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:05:14.739387Z","time spent":"489.166754ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-13T01:05:15.228575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.35963ms","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-06-13T01:05:15.228632Z","caller":"traceutil/trace.go:171","msg":"trace[341782525] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2027; }","duration":"494.471032ms","start":"2026-06-13T01:05:14.734145Z","end":"2026-06-13T01:05:15.228616Z","steps":["trace[341782525] 'agreement among raft nodes before linearized reading' (duration: 493.187432ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:15.228683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:05:14.734117Z","time spent":"494.556634ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-13T01:05:15.547992Z","caller":"traceutil/trace.go:171","msg":"trace[1329636605] transaction","detail":"{read_only:false; response_revision:2029; number_of_response:1; }","duration":"314.353191ms","start":"2026-06-13T01:05:15.233601Z","end":"2026-06-13T01:05:15.547954Z","steps":["trace[1329636605] 'process raft request' (duration: 309.057505ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:15.548216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:05:15.23358Z","time spent":"314.506433ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T01:05:15.548488Z","caller":"traceutil/trace.go:171","msg":"trace[602842708] transaction","detail":"{read_only:false; response_revision:2030; number_of_response:1; }","duration":"314.811729ms","start":"2026-06-13T01:05:15.233649Z","end":"2026-06-13T01:05:15.54846Z","steps":["trace[602842708] 'process raft request' (duration: 314.197148ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:15.548707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:05:15.233624Z","time spent":"314.994842ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T01:05:15.549163Z","caller":"traceutil/trace.go:171","msg":"trace[2025669891] transaction","detail":"{read_only:false; response_revision:2031; number_of_response:1; }","duration":"315.369568ms","start":"2026-06-13T01:05:15.233753Z","end":"2026-06-13T01:05:15.549122Z","steps":["trace[2025669891] 'process raft request' (duration: 314.657266ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:15.549378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:05:15.233743Z","time spent":"315.51863ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T01:05:16.716062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.303314ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T01:05:16.716488Z","caller":"traceutil/trace.go:171","msg":"trace[44116846] linearizableReadLoop","detail":"{readStateIndex:2116; appliedIndex:2114; }","duration":"180.533129ms","start":"2026-06-13T01:05:16.535925Z","end":"2026-06-13T01:05:16.716458Z","steps":["trace[44116846] 'read index received' (duration: 39.634594ms)","trace[44116846] 'applied index is now lower than readState.Index' (duration: 140.896094ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:05:16.716581Z","caller":"traceutil/trace.go:171","msg":"trace[2065293355] transaction","detail":"{read_only:false; response_revision:2033; number_of_response:1; }","duration":"186.73462ms","start":"2026-06-13T01:05:16.529769Z","end":"2026-06-13T01:05:16.716503Z","steps":["trace[2065293355] 'process raft request' (duration: 186.453755ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:05:16.716649Z","caller":"traceutil/trace.go:171","msg":"trace[396986776] transaction","detail":"{read_only:false; response_revision:2034; number_of_response:1; }","duration":"179.512882ms","start":"2026-06-13T01:05:16.537095Z","end":"2026-06-13T01:05:16.716608Z","steps":["trace[396986776] 'process raft request' (duration: 179.271948ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:16.717161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.028188ms","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":"warn","ts":"2026-06-13T01:05:16.717141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.18025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T01:05:16.717224Z","caller":"traceutil/trace.go:171","msg":"trace[817956044] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2034; }","duration":"159.1169ms","start":"2026-06-13T01:05:16.55809Z","end":"2026-06-13T01:05:16.717207Z","steps":["trace[817956044] 'agreement among raft nodes before linearized reading' (duration: 158.791235ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:05:16.716465Z","caller":"traceutil/trace.go:171","msg":"trace[24709897] transaction","detail":"{read_only:false; response_revision:2032; number_of_response:1; }","duration":"310.352471ms","start":"2026-06-13T01:05:16.405968Z","end":"2026-06-13T01:05:16.716321Z","steps":["trace[24709897] 'process raft request' (duration: 169.63324ms)","trace[24709897] 'compare' (duration: 140.05024ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:05:16.717318Z","caller":"traceutil/trace.go:171","msg":"trace[848151920] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2034; }","duration":"181.397723ms","start":"2026-06-13T01:05:16.535843Z","end":"2026-06-13T01:05:16.717241Z","steps":["trace[848151920] 'agreement among raft nodes before linearized reading' (duration: 181.000367ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:16.717512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:05:16.40594Z","time spent":"311.419198ms","remote":"127.0.0.1:45834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T01:05:19.399288Z","caller":"traceutil/trace.go:171","msg":"trace[439316479] transaction","detail":"{read_only:false; response_revision:2047; number_of_response:1; }","duration":"152.820608ms","start":"2026-06-13T01:05:19.246436Z","end":"2026-06-13T01:05:19.399257Z","steps":["trace[439316479] 'process raft request' (duration: 152.612345ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:05:19.501868Z","caller":"traceutil/trace.go:171","msg":"trace[1790670709] transaction","detail":"{read_only:false; response_revision:2048; number_of_response:1; }","duration":"249.212356ms","start":"2026-06-13T01:05:19.252615Z","end":"2026-06-13T01:05:19.501828Z","steps":["trace[1790670709] 'process raft request' (duration: 248.885171ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:05:19.502037Z","caller":"traceutil/trace.go:171","msg":"trace[591349862] linearizableReadLoop","detail":"{readStateIndex:2132; appliedIndex:2129; }","duration":"168.722342ms","start":"2026-06-13T01:05:19.333285Z","end":"2026-06-13T01:05:19.502007Z","steps":["trace[591349862] 'read index received' (duration: 65.811119ms)","trace[591349862] 'applied index is now lower than readState.Index' (duration: 102.909223ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:05:19.502169Z","caller":"traceutil/trace.go:171","msg":"trace[1942149989] transaction","detail":"{read_only:false; response_revision:2049; number_of_response:1; }","duration":"249.41717ms","start":"2026-06-13T01:05:19.252721Z","end":"2026-06-13T01:05:19.502138Z","steps":["trace[1942149989] 'process raft request' (duration: 249.067714ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:19.50225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.949396ms","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-06-13T01:05:19.50228Z","caller":"traceutil/trace.go:171","msg":"trace[698049960] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2049; }","duration":"169.063977ms","start":"2026-06-13T01:05:19.333207Z","end":"2026-06-13T01:05:19.502271Z","steps":["trace[698049960] 'agreement among raft nodes before linearized reading' (duration: 168.865284ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:21.254299Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656053326625020257,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-13T01:05:21.291316Z","caller":"traceutil/trace.go:171","msg":"trace[1532593801] transaction","detail":"{read_only:false; response_revision:2055; number_of_response:1; }","duration":"555.037019ms","start":"2026-06-13T01:05:20.736244Z","end":"2026-06-13T01:05:21.291281Z","steps":["trace[1532593801] 'process raft request' (duration: 554.809406ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:21.291546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:05:20.736218Z","time spent":"555.201381ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T01:05:21.292069Z","caller":"traceutil/trace.go:171","msg":"trace[1691795560] linearizableReadLoop","detail":"{readStateIndex:2139; appliedIndex:2137; }","duration":"538.158891ms","start":"2026-06-13T01:05:20.753888Z","end":"2026-06-13T01:05:21.292047Z","steps":["trace[1691795560] 'read index received' (duration: 537.116655ms)","trace[1691795560] 'applied index is now lower than readState.Index' (duration: 1.041196ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T01:05:21.292252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.349945ms","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-06-13T01:05:21.292273Z","caller":"traceutil/trace.go:171","msg":"trace[1724190783] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2056; }","duration":"538.439665ms","start":"2026-06-13T01:05:20.753825Z","end":"2026-06-13T01:05:21.292265Z","steps":["trace[1724190783] 'agreement among raft nodes before linearized reading' (duration: 538.305343ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:21.292296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:05:20.753801Z","time spent":"538.489457ms","remote":"127.0.0.1:54838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-06-13T01:05:21.292322Z","caller":"traceutil/trace.go:171","msg":"trace[1141120562] transaction","detail":"{read_only:false; response_revision:2056; number_of_response:1; }","duration":"555.368574ms","start":"2026-06-13T01:05:20.736922Z","end":"2026-06-13T01:05:21.29229Z","steps":["trace[1141120562] 'process raft request' (duration: 554.987168ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:21.293559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:05:20.736902Z","time spent":"555.629268ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T01:05:42.11941Z","caller":"traceutil/trace.go:171","msg":"trace[152806735] transaction","detail":"{read_only:false; response_revision:2177; number_of_response:1; }","duration":"126.457993ms","start":"2026-06-13T01:05:41.992927Z","end":"2026-06-13T01:05:42.119385Z","steps":["trace[152806735] 'process raft request' (duration: 126.275461ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:05:42.612591Z","caller":"traceutil/trace.go:171","msg":"trace[2129006570] linearizableReadLoop","detail":"{readStateIndex:2266; appliedIndex:2265; }","duration":"174.331991ms","start":"2026-06-13T01:05:42.438243Z","end":"2026-06-13T01:05:42.612575Z","steps":["trace[2129006570] 'read index received' (duration: 174.220239ms)","trace[2129006570] 'applied index is now lower than readState.Index' (duration: 111.132µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:05:42.612763Z","caller":"traceutil/trace.go:171","msg":"trace[1175642930] transaction","detail":"{read_only:false; response_revision:2178; number_of_response:1; }","duration":"220.732697ms","start":"2026-06-13T01:05:42.391926Z","end":"2026-06-13T01:05:42.612658Z","steps":["trace[1175642930] 'process raft request' (duration: 220.531404ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:42.61284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.579534ms","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-06-13T01:05:42.613168Z","caller":"traceutil/trace.go:171","msg":"trace[753859928] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2178; }","duration":"174.844957ms","start":"2026-06-13T01:05:42.4382Z","end":"2026-06-13T01:05:42.613045Z","steps":["trace[753859928] 'agreement among raft nodes before linearized reading' (duration: 174.543933ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:05:43.342953Z","caller":"traceutil/trace.go:171","msg":"trace[1356611499] transaction","detail":"{read_only:false; response_revision:2180; number_of_response:1; }","duration":"139.613416ms","start":"2026-06-13T01:05:43.203316Z","end":"2026-06-13T01:05:43.342929Z","steps":["trace[1356611499] 'process raft request' (duration: 139.376232ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:05:43.668143Z","caller":"traceutil/trace.go:171","msg":"trace[841528703] linearizableReadLoop","detail":"{readStateIndex:2273; appliedIndex:2272; }","duration":"152.634827ms","start":"2026-06-13T01:05:43.515475Z","end":"2026-06-13T01:05:43.66811Z","steps":["trace[841528703] 'read index received' (duration: 152.379822ms)","trace[841528703] 'applied index is now lower than readState.Index' (duration: 253.825µs)"],"step_count":2} {"level":"warn","ts":"2026-06-13T01:05:43.668336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.84218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T01:05:43.668378Z","caller":"traceutil/trace.go:171","msg":"trace[1588808028] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:2184; }","duration":"152.937671ms","start":"2026-06-13T01:05:43.515432Z","end":"2026-06-13T01:05:43.66837Z","steps":["trace[1588808028] 'agreement among raft nodes before linearized reading' (duration: 152.84901ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:05:43.668235Z","caller":"traceutil/trace.go:171","msg":"trace[1907897256] transaction","detail":"{read_only:false; response_revision:2184; number_of_response:1; }","duration":"165.706329ms","start":"2026-06-13T01:05:43.502508Z","end":"2026-06-13T01:05:43.668214Z","steps":["trace[1907897256] 'process raft request' (duration: 165.289103ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:44.528923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.631649ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T01:05:44.529026Z","caller":"traceutil/trace.go:171","msg":"trace[913668581] linearizableReadLoop","detail":"{readStateIndex:2274; appliedIndex:2273; }","duration":"860.665797ms","start":"2026-06-13T01:05:43.66834Z","end":"2026-06-13T01:05:44.529006Z","steps":["trace[913668581] 'read index received' (duration: 335.774505ms)","trace[913668581] 'applied index is now lower than readState.Index' (duration: 524.890182ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:05:44.529279Z","caller":"traceutil/trace.go:171","msg":"trace[928576740] transaction","detail":"{read_only:false; response_revision:2185; number_of_response:1; }","duration":"950.38422ms","start":"2026-06-13T01:05:43.578882Z","end":"2026-06-13T01:05:44.529266Z","steps":["trace[928576740] 'process raft request' (duration: 425.330976ms)","trace[928576740] 'compare' (duration: 523.911149ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T01:05:44.529405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:05:43.578862Z","time spent":"950.494363ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T01:05:44.529651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.005432554s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-13T01:05:44.52969Z","caller":"traceutil/trace.go:171","msg":"trace[2019190685] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:2185; }","duration":"1.005497276s","start":"2026-06-13T01:05:43.524183Z","end":"2026-06-13T01:05:44.52968Z","steps":["trace[2019190685] 'agreement among raft nodes before linearized reading' (duration: 1.005422405s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:44.529722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:05:43.524172Z","time spent":"1.005542496s","remote":"127.0.0.1:46110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":30,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-13T01:05:44.529698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"992.303963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-13T01:05:44.529903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"909.638536ms","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-06-13T01:05:44.529997Z","caller":"traceutil/trace.go:171","msg":"trace[1720287303] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2185; }","duration":"909.790989ms","start":"2026-06-13T01:05:43.62018Z","end":"2026-06-13T01:05:44.529971Z","steps":["trace[1720287303] 'agreement among raft nodes before linearized reading' (duration: 909.524205ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:44.530047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:05:43.620159Z","time spent":"909.87907ms","remote":"127.0.0.1:54838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-13T01:05:44.530079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"846.010214ms","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-06-13T01:05:44.530189Z","caller":"traceutil/trace.go:171","msg":"trace[1945164224] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2185; }","duration":"846.182606ms","start":"2026-06-13T01:05:43.683982Z","end":"2026-06-13T01:05:44.530165Z","steps":["trace[1945164224] 'agreement among raft nodes before linearized reading' (duration: 845.775901ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:05:44.529886Z","caller":"traceutil/trace.go:171","msg":"trace[1929919566] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2185; }","duration":"992.530845ms","start":"2026-06-13T01:05:43.53733Z","end":"2026-06-13T01:05:44.529861Z","steps":["trace[1929919566] 'agreement among raft nodes before linearized reading' (duration: 992.248021ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:44.530415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"815.276578ms","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-06-13T01:05:44.53044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"815.903286ms","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-06-13T01:05:44.530462Z","caller":"traceutil/trace.go:171","msg":"trace[101862393] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2185; }","duration":"815.340288ms","start":"2026-06-13T01:05:43.715113Z","end":"2026-06-13T01:05:44.530454Z","steps":["trace[101862393] 'agreement among raft nodes before linearized reading' (duration: 815.187196ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:05:44.530483Z","caller":"traceutil/trace.go:171","msg":"trace[2094813140] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2185; }","duration":"815.972816ms","start":"2026-06-13T01:05:43.7145Z","end":"2026-06-13T01:05:44.530472Z","steps":["trace[2094813140] 'agreement among raft nodes before linearized reading' (duration: 815.842765ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:44.530529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:05:43.714483Z","time spent":"816.038738ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-13T01:05:44.530533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"908.820604ms","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-06-13T01:05:44.530495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:05:43.715105Z","time spent":"815.383629ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-13T01:05:44.530644Z","caller":"traceutil/trace.go:171","msg":"trace[2164871] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2185; }","duration":"908.964967ms","start":"2026-06-13T01:05:43.621663Z","end":"2026-06-13T01:05:44.530627Z","steps":["trace[2164871] 'agreement among raft nodes before linearized reading' (duration: 908.268727ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:44.530718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:05:43.621648Z","time spent":"909.056928ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-13T01:05:44.530251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:05:43.68396Z","time spent":"846.281207ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-13T01:05:44.530477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:05:43.537319Z","time spent":"993.140543ms","remote":"127.0.0.1:45802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-13T01:05:44.531995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"910.347835ms","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-06-13T01:05:44.532179Z","caller":"traceutil/trace.go:171","msg":"trace[600879633] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2185; }","duration":"910.609099ms","start":"2026-06-13T01:05:43.621549Z","end":"2026-06-13T01:05:44.532158Z","steps":["trace[600879633] 'agreement among raft nodes before linearized reading' (duration: 908.123615ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:44.532306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:05:43.621523Z","time spent":"910.768682ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-13T01:05:45.143623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.596812ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T01:05:45.143773Z","caller":"traceutil/trace.go:171","msg":"trace[272803254] transaction","detail":"{read_only:false; response_revision:2186; number_of_response:1; }","duration":"607.281579ms","start":"2026-06-13T01:05:44.536466Z","end":"2026-06-13T01:05:45.143747Z","steps":["trace[272803254] 'process raft request' (duration: 273.375282ms)","trace[272803254] 'compare' (duration: 333.359589ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T01:05:45.144343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:05:44.536437Z","time spent":"607.714354ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T01:05:45.159519Z","caller":"traceutil/trace.go:171","msg":"trace[1594870988] linearizableReadLoop","detail":"{readStateIndex:2279; appliedIndex:2274; }","duration":"620.552001ms","start":"2026-06-13T01:05:44.538927Z","end":"2026-06-13T01:05:45.159479Z","steps":["trace[1594870988] 'read index received' (duration: 270.928998ms)","trace[1594870988] 'applied index is now lower than readState.Index' (duration: 349.621663ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:05:45.159523Z","caller":"traceutil/trace.go:171","msg":"trace[501244223] transaction","detail":"{read_only:false; response_revision:2187; number_of_response:1; }","duration":"622.70768ms","start":"2026-06-13T01:05:44.536777Z","end":"2026-06-13T01:05:45.159484Z","steps":["trace[501244223] 'process raft request' (duration: 622.455926ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:05:45.159611Z","caller":"traceutil/trace.go:171","msg":"trace[547484064] transaction","detail":"{read_only:false; response_revision:2189; number_of_response:1; }","duration":"622.452376ms","start":"2026-06-13T01:05:44.537142Z","end":"2026-06-13T01:05:45.159594Z","steps":["trace[547484064] 'process raft request' (duration: 622.230033ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:45.159648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:05:44.536767Z","time spent":"622.829101ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T01:05:45.159651Z","caller":"traceutil/trace.go:171","msg":"trace[556985722] transaction","detail":"{read_only:false; response_revision:2190; number_of_response:1; }","duration":"622.337005ms","start":"2026-06-13T01:05:44.537298Z","end":"2026-06-13T01:05:45.159635Z","steps":["trace[556985722] 'process raft request' (duration: 622.126182ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:45.15969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:05:44.537136Z","time spent":"622.508987ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T01:05:45.159731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:05:44.537293Z","time spent":"622.396196ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T01:05:45.159817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.816734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T01:05:45.159853Z","caller":"traceutil/trace.go:171","msg":"trace[687432634] transaction","detail":"{read_only:false; response_revision:2188; number_of_response:1; }","duration":"622.942693ms","start":"2026-06-13T01:05:44.536819Z","end":"2026-06-13T01:05:45.159762Z","steps":["trace[687432634] 'process raft request' (duration: 622.507547ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:05:45.159952Z","caller":"traceutil/trace.go:171","msg":"trace[1170797332] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2190; }","duration":"620.999436ms","start":"2026-06-13T01:05:44.538906Z","end":"2026-06-13T01:05:45.159905Z","steps":["trace[1170797332] 'agreement among raft nodes before linearized reading' (duration: 620.769793ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:05:45.160031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:05:44.5389Z","time spent":"621.097498ms","remote":"127.0.0.1:45800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-13T01:05:45.160096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:05:44.536815Z","time spent":"623.158535ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T01:05:45.621387Z","caller":"traceutil/trace.go:171","msg":"trace[282579245] transaction","detail":"{read_only:false; response_revision:2191; number_of_response:1; }","duration":"204.679ms","start":"2026-06-13T01:05:45.416678Z","end":"2026-06-13T01:05:45.621357Z","steps":["trace[282579245] 'process raft request' (duration: 204.208364ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:05:45.622469Z","caller":"traceutil/trace.go:171","msg":"trace[1183552380] transaction","detail":"{read_only:false; response_revision:2192; number_of_response:1; }","duration":"205.430779ms","start":"2026-06-13T01:05:45.417007Z","end":"2026-06-13T01:05:45.622438Z","steps":["trace[1183552380] 'process raft request' (duration: 205.243777ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:06:52.827828Z","caller":"traceutil/trace.go:171","msg":"trace[922524081] transaction","detail":"{read_only:false; response_revision:2593; number_of_response:1; }","duration":"302.894129ms","start":"2026-06-13T01:06:52.524908Z","end":"2026-06-13T01:06:52.827802Z","steps":["trace[922524081] 'process raft request' (duration: 302.730517ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:06:52.827989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:06:52.52489Z","time spent":"303.01325ms","remote":"127.0.0.1:46014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8041,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T01:07:01.19905Z","caller":"traceutil/trace.go:171","msg":"trace[1401967304] transaction","detail":"{read_only:false; response_revision:2694; number_of_response:1; }","duration":"337.012143ms","start":"2026-06-13T01:07:00.861984Z","end":"2026-06-13T01:07:01.198996Z","steps":["trace[1401967304] 'process raft request' (duration: 336.879142ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:07:01.199217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:07:00.861963Z","time spent":"337.180205ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T01:07:29.357111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.492707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-13T01:07:29.357174Z","caller":"traceutil/trace.go:171","msg":"trace[530364437] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:2851; }","duration":"291.631389ms","start":"2026-06-13T01:07:29.06553Z","end":"2026-06-13T01:07:29.357162Z","steps":["trace[530364437] 'count revisions from in-memory index tree' (duration: 291.393596ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:07:35.580023Z","caller":"traceutil/trace.go:171","msg":"trace[491410353] transaction","detail":"{read_only:false; response_revision:2882; number_of_response:1; }","duration":"307.420415ms","start":"2026-06-13T01:07:35.272579Z","end":"2026-06-13T01:07:35.579999Z","steps":["trace[491410353] 'process raft request' (duration: 307.297964ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:07:35.580182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:07:35.272551Z","time spent":"307.548077ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T01:07:36.345171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.910346ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T01:07:36.345288Z","caller":"traceutil/trace.go:171","msg":"trace[2128432216] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2882; }","duration":"296.047627ms","start":"2026-06-13T01:07:36.049224Z","end":"2026-06-13T01:07:36.345272Z","steps":["trace[2128432216] 'range keys from in-memory index tree' (duration: 295.891526ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:07:36.346256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.753876ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T01:07:36.346509Z","caller":"traceutil/trace.go:171","msg":"trace[1390290781] transaction","detail":"{read_only:false; response_revision:2883; number_of_response:1; }","duration":"966.688351ms","start":"2026-06-13T01:07:35.379763Z","end":"2026-06-13T01:07:36.346452Z","steps":["trace[1390290781] 'process raft request' (duration: 539.59184ms)","trace[1390290781] 'compare' (duration: 426.343972ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:07:36.346559Z","caller":"traceutil/trace.go:171","msg":"trace[668081254] transaction","detail":"{read_only:false; response_revision:2884; number_of_response:1; }","duration":"477.471339ms","start":"2026-06-13T01:07:35.869067Z","end":"2026-06-13T01:07:36.346538Z","steps":["trace[668081254] 'process raft request' (duration: 477.308197ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:07:36.346562Z","caller":"traceutil/trace.go:171","msg":"trace[286595433] linearizableReadLoop","detail":"{readStateIndex:2996; appliedIndex:2994; }","duration":"808.885796ms","start":"2026-06-13T01:07:35.53766Z","end":"2026-06-13T01:07:36.346546Z","steps":["trace[286595433] 'read index received' (duration: 42.286987ms)","trace[286595433] 'applied index is now lower than readState.Index' (duration: 766.597619ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T01:07:36.346753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"809.073627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T01:07:36.346869Z","caller":"traceutil/trace.go:171","msg":"trace[253558646] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2884; }","duration":"809.22452ms","start":"2026-06-13T01:07:35.537628Z","end":"2026-06-13T01:07:36.346852Z","steps":["trace[253558646] 'agreement among raft nodes before linearized reading' (duration: 809.048938ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:07:36.346873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:07:35.869046Z","time spent":"477.5606ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T01:07:36.346938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:07:35.537614Z","time spent":"809.31292ms","remote":"127.0.0.1:45800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-13T01:07:36.346764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:07:35.379733Z","time spent":"966.846402ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T01:07:36.732268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.757481ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T01:07:36.732579Z","caller":"traceutil/trace.go:171","msg":"trace[2119242881] linearizableReadLoop","detail":"{readStateIndex:3000; appliedIndex:2997; }","duration":"385.910962ms","start":"2026-06-13T01:07:36.346652Z","end":"2026-06-13T01:07:36.732563Z","steps":["trace[2119242881] 'read index received' (duration: 114.854328ms)","trace[2119242881] 'applied index is now lower than readState.Index' (duration: 271.055934ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T01:07:36.732702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"704.648208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-13T01:07:36.732774Z","caller":"traceutil/trace.go:171","msg":"trace[672086927] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:2887; }","duration":"704.751989ms","start":"2026-06-13T01:07:36.028Z","end":"2026-06-13T01:07:36.732752Z","steps":["trace[672086927] 'agreement among raft nodes before linearized reading' (duration: 704.618397ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:07:36.732785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"926.750281ms","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-06-13T01:07:36.732846Z","caller":"traceutil/trace.go:171","msg":"trace[568902874] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2887; }","duration":"926.847901ms","start":"2026-06-13T01:07:35.805985Z","end":"2026-06-13T01:07:36.732833Z","steps":["trace[568902874] 'agreement among raft nodes before linearized reading' (duration: 926.644669ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:07:36.732883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:07:35.805972Z","time spent":"926.903522ms","remote":"127.0.0.1:46098","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":"info","ts":"2026-06-13T01:07:36.732912Z","caller":"traceutil/trace.go:171","msg":"trace[1827349145] transaction","detail":"{read_only:false; response_revision:2886; number_of_response:1; }","duration":"608.191685ms","start":"2026-06-13T01:07:36.124706Z","end":"2026-06-13T01:07:36.732898Z","steps":["trace[1827349145] 'process raft request' (duration: 607.68652ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:07:36.733013Z","caller":"traceutil/trace.go:171","msg":"trace[1943637684] transaction","detail":"{read_only:false; response_revision:2885; number_of_response:1; }","duration":"615.406537ms","start":"2026-06-13T01:07:36.11743Z","end":"2026-06-13T01:07:36.732837Z","steps":["trace[1943637684] 'process raft request' (duration: 343.96911ms)","trace[1943637684] 'compare' (duration: 270.591409ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T01:07:36.73306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"884.336354ms","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-06-13T01:07:36.733088Z","caller":"traceutil/trace.go:171","msg":"trace[1873650354] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2887; }","duration":"884.385224ms","start":"2026-06-13T01:07:35.848696Z","end":"2026-06-13T01:07:36.733081Z","steps":["trace[1873650354] 'agreement among raft nodes before linearized reading' (duration: 884.317003ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:07:36.733109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:07:35.84868Z","time spent":"884.425444ms","remote":"127.0.0.1:46098","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-06-13T01:07:36.733182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"884.503545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-13T01:07:36.733203Z","caller":"traceutil/trace.go:171","msg":"trace[858323216] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2887; }","duration":"884.545905ms","start":"2026-06-13T01:07:35.84865Z","end":"2026-06-13T01:07:36.733196Z","steps":["trace[858323216] 'agreement among raft nodes before linearized reading' (duration: 884.497574ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:07:36.733218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:07:35.848639Z","time spent":"884.575765ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-13T01:07:36.733253Z","caller":"traceutil/trace.go:171","msg":"trace[1201741531] transaction","detail":"{read_only:false; response_revision:2887; number_of_response:1; }","duration":"589.126423ms","start":"2026-06-13T01:07:36.143834Z","end":"2026-06-13T01:07:36.73296Z","steps":["trace[1201741531] 'process raft request' (duration: 588.692838ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:07:36.733649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.808155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.227\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-13T01:07:36.733676Z","caller":"traceutil/trace.go:171","msg":"trace[279647157] range","detail":"{range_begin:/registry/masterleases/199.204.45.227; range_end:; response_count:1; response_revision:2887; }","duration":"527.869676ms","start":"2026-06-13T01:07:36.2058Z","end":"2026-06-13T01:07:36.733669Z","steps":["trace[279647157] 'agreement among raft nodes before linearized reading' (duration: 527.811335ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:07:36.733696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:07:36.205779Z","time spent":"527.912346ms","remote":"127.0.0.1:45834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.227\" "} {"level":"warn","ts":"2026-06-13T01:07:36.733792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:07:36.143821Z","time spent":"589.883641ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T01:07:36.733054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:07:36.124687Z","time spent":"608.286757ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T01:07:36.733291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"926.653191ms","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-06-13T01:07:36.73399Z","caller":"traceutil/trace.go:171","msg":"trace[791037856] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2887; }","duration":"927.366138ms","start":"2026-06-13T01:07:35.806616Z","end":"2026-06-13T01:07:36.733982Z","steps":["trace[791037856] 'agreement among raft nodes before linearized reading' (duration: 926.64148ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:07:36.73281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:07:36.027986Z","time spent":"704.81691ms","remote":"127.0.0.1:46296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":12,"response size":30,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"warn","ts":"2026-06-13T01:07:36.734065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:07:35.806608Z","time spent":"927.415538ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-13T01:07:36.733437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.140495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T01:07:36.734116Z","caller":"traceutil/trace.go:171","msg":"trace[2098661209] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2887; }","duration":"383.850793ms","start":"2026-06-13T01:07:36.350256Z","end":"2026-06-13T01:07:36.734107Z","steps":["trace[2098661209] 'agreement among raft nodes before linearized reading' (duration: 383.163206ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:07:36.734148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:07:36.350238Z","time spent":"383.901723ms","remote":"127.0.0.1:45802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-13T01:07:36.733488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"958.167849ms","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-06-13T01:07:36.734378Z","caller":"traceutil/trace.go:171","msg":"trace[1580804678] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2887; }","duration":"959.063257ms","start":"2026-06-13T01:07:35.775307Z","end":"2026-06-13T01:07:36.734371Z","steps":["trace[1580804678] 'agreement among raft nodes before linearized reading' (duration: 958.141838ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:07:36.734552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:07:35.775236Z","time spent":"959.30549ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-13T01:07:36.733534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.979464ms","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-06-13T01:07:36.734834Z","caller":"traceutil/trace.go:171","msg":"trace[1775525907] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2887; }","duration":"160.320507ms","start":"2026-06-13T01:07:36.574506Z","end":"2026-06-13T01:07:36.734827Z","steps":["trace[1775525907] 'agreement among raft nodes before linearized reading' (duration: 158.991264ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:07:36.733593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"942.497171ms","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-06-13T01:07:36.735113Z","caller":"traceutil/trace.go:171","msg":"trace[559988104] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2887; }","duration":"944.072737ms","start":"2026-06-13T01:07:35.791032Z","end":"2026-06-13T01:07:36.735105Z","steps":["trace[559988104] 'agreement among raft nodes before linearized reading' (duration: 941.598711ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:07:36.733616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:07:36.117415Z","time spent":"615.62673ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T01:07:36.736507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:07:35.791011Z","time spent":"945.480761ms","remote":"127.0.0.1:54746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-06-13T01:09:55.137965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.060291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T01:09:55.138062Z","caller":"traceutil/trace.go:171","msg":"trace[1254066599] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:3703; }","duration":"162.208955ms","start":"2026-06-13T01:09:54.975833Z","end":"2026-06-13T01:09:55.138041Z","steps":["trace[1254066599] 'range keys from in-memory index tree' (duration: 161.976459ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:10:49.235101Z","caller":"traceutil/trace.go:171","msg":"trace[952028921] transaction","detail":"{read_only:false; response_revision:4067; number_of_response:1; }","duration":"117.215147ms","start":"2026-06-13T01:10:49.117862Z","end":"2026-06-13T01:10:49.235077Z","steps":["trace[952028921] 'process raft request' (duration: 117.049574ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:09.965079Z","caller":"traceutil/trace.go:171","msg":"trace[1739209775] transaction","detail":"{read_only:false; response_revision:4460; number_of_response:1; }","duration":"116.091485ms","start":"2026-06-13T01:11:09.848963Z","end":"2026-06-13T01:11:09.965055Z","steps":["trace[1739209775] 'process raft request' (duration: 104.18258ms)","trace[1739209775] 'compare' (duration: 11.811003ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:11:10.164496Z","caller":"traceutil/trace.go:171","msg":"trace[1897160300] transaction","detail":"{read_only:false; response_revision:4467; number_of_response:1; }","duration":"130.261186ms","start":"2026-06-13T01:11:10.034213Z","end":"2026-06-13T01:11:10.164474Z","steps":["trace[1897160300] 'process raft request' (duration: 87.099253ms)","trace[1897160300] 'compare' (duration: 42.659964ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:11:10.164789Z","caller":"traceutil/trace.go:171","msg":"trace[1864893015] transaction","detail":"{read_only:false; response_revision:4468; number_of_response:1; }","duration":"107.58759ms","start":"2026-06-13T01:11:10.057191Z","end":"2026-06-13T01:11:10.164778Z","steps":["trace[1864893015] 'process raft request' (duration: 107.232412ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:10.582527Z","caller":"traceutil/trace.go:171","msg":"trace[657496180] transaction","detail":"{read_only:false; response_revision:4506; number_of_response:1; }","duration":"162.649437ms","start":"2026-06-13T01:11:10.419839Z","end":"2026-06-13T01:11:10.582488Z","steps":["trace[657496180] 'process raft request' (duration: 107.822573ms)","trace[657496180] 'compare' (duration: 54.408397ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T01:11:10.582687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.144853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/grafana-tls\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T01:11:10.582736Z","caller":"traceutil/trace.go:171","msg":"trace[752412387] range","detail":"{range_begin:/registry/secrets/monitoring/grafana-tls; range_end:; response_count:0; response_revision:4508; }","duration":"105.249956ms","start":"2026-06-13T01:11:10.477477Z","end":"2026-06-13T01:11:10.582727Z","steps":["trace[752412387] 'agreement among raft nodes before linearized reading' (duration: 105.128173ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:10.582542Z","caller":"traceutil/trace.go:171","msg":"trace[540264844] linearizableReadLoop","detail":"{readStateIndex:4688; appliedIndex:4686; }","duration":"104.994831ms","start":"2026-06-13T01:11:10.477511Z","end":"2026-06-13T01:11:10.582506Z","steps":["trace[540264844] 'read index received' (duration: 49.981003ms)","trace[540264844] 'applied index is now lower than readState.Index' (duration: 55.009668ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:11:10.582897Z","caller":"traceutil/trace.go:171","msg":"trace[10187820] transaction","detail":"{read_only:false; response_revision:4507; number_of_response:1; }","duration":"151.857554ms","start":"2026-06-13T01:11:10.43103Z","end":"2026-06-13T01:11:10.582887Z","steps":["trace[10187820] 'process raft request' (duration: 151.340394ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:10.752507Z","caller":"traceutil/trace.go:171","msg":"trace[1661795730] linearizableReadLoop","detail":"{readStateIndex:4691; appliedIndex:4690; }","duration":"106.109421ms","start":"2026-06-13T01:11:10.646374Z","end":"2026-06-13T01:11:10.752484Z","steps":["trace[1661795730] 'read index received' (duration: 82.15624ms)","trace[1661795730] 'applied index is now lower than readState.Index' (duration: 23.952191ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:11:10.752621Z","caller":"traceutil/trace.go:171","msg":"trace[1976899264] transaction","detail":"{read_only:false; response_revision:4510; number_of_response:1; }","duration":"140.026761ms","start":"2026-06-13T01:11:10.612554Z","end":"2026-06-13T01:11:10.752581Z","steps":["trace[1976899264] 'process raft request' (duration: 116.045239ms)","trace[1976899264] 'compare' (duration: 23.778048ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T01:11:10.752674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.277745ms","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-06-13T01:11:10.752742Z","caller":"traceutil/trace.go:171","msg":"trace[348472539] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:4510; }","duration":"106.399497ms","start":"2026-06-13T01:11:10.646327Z","end":"2026-06-13T01:11:10.752727Z","steps":["trace[348472539] 'agreement among raft nodes before linearized reading' (duration: 106.255824ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:10.754416Z","caller":"traceutil/trace.go:171","msg":"trace[398534132] transaction","detail":"{read_only:false; response_revision:4511; number_of_response:1; }","duration":"106.002529ms","start":"2026-06-13T01:11:10.648376Z","end":"2026-06-13T01:11:10.754378Z","steps":["trace[398534132] 'process raft request' (duration: 105.645632ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:10.939051Z","caller":"traceutil/trace.go:171","msg":"trace[2024190990] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4515; }","duration":"152.609568ms","start":"2026-06-13T01:11:10.786405Z","end":"2026-06-13T01:11:10.939015Z","steps":["trace[2024190990] 'process raft request' (duration: 99.895714ms)","trace[2024190990] 'compare' (duration: 52.570372ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:11:11.311612Z","caller":"traceutil/trace.go:171","msg":"trace[586026910] transaction","detail":"{read_only:false; response_revision:4524; number_of_response:1; }","duration":"131.857931ms","start":"2026-06-13T01:11:11.179725Z","end":"2026-06-13T01:11:11.311583Z","steps":["trace[586026910] 'process raft request' (duration: 124.39521ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:11.311768Z","caller":"traceutil/trace.go:171","msg":"trace[1362366032] linearizableReadLoop","detail":"{readStateIndex:4707; appliedIndex:4706; }","duration":"111.940756ms","start":"2026-06-13T01:11:11.199777Z","end":"2026-06-13T01:11:11.311718Z","steps":["trace[1362366032] 'read index received' (duration: 104.427205ms)","trace[1362366032] 'applied index is now lower than readState.Index' (duration: 7.509411ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T01:11:11.317862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.057681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-13T01:11:11.317908Z","caller":"traceutil/trace.go:171","msg":"trace[401278904] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:4524; }","duration":"118.192853ms","start":"2026-06-13T01:11:11.199704Z","end":"2026-06-13T01:11:11.317897Z","steps":["trace[401278904] 'agreement among raft nodes before linearized reading' (duration: 112.16272ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:16.77138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.203616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:3958"} {"level":"info","ts":"2026-06-13T01:11:16.771442Z","caller":"traceutil/trace.go:171","msg":"trace[1865287568] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4624; }","duration":"119.276347ms","start":"2026-06-13T01:11:16.652152Z","end":"2026-06-13T01:11:16.771428Z","steps":["trace[1865287568] 'range keys from in-memory index tree' (duration: 119.145715ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:16.771564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.569488ms","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-06-13T01:11:16.771582Z","caller":"traceutil/trace.go:171","msg":"trace[1503565619] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4624; }","duration":"122.597688ms","start":"2026-06-13T01:11:16.648979Z","end":"2026-06-13T01:11:16.771577Z","steps":["trace[1503565619] 'range keys from in-memory index tree' (duration: 122.501327ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:16.773324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.190886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4737"} {"level":"info","ts":"2026-06-13T01:11:16.773462Z","caller":"traceutil/trace.go:171","msg":"trace[2097497683] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4624; }","duration":"119.43286ms","start":"2026-06-13T01:11:16.654001Z","end":"2026-06-13T01:11:16.773434Z","steps":["trace[2097497683] 'range keys from in-memory index tree' (duration: 119.119534ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:16.770637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.016457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:11983"} {"level":"info","ts":"2026-06-13T01:11:16.775039Z","caller":"traceutil/trace.go:171","msg":"trace[1456462392] range","detail":"{range_begin:/registry/statefulsets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4624; }","duration":"119.456619ms","start":"2026-06-13T01:11:16.655535Z","end":"2026-06-13T01:11:16.774991Z","steps":["trace[1456462392] 'range keys from in-memory index tree' (duration: 114.818294ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:16.879345Z","caller":"traceutil/trace.go:171","msg":"trace[1538182859] linearizableReadLoop","detail":"{readStateIndex:4810; appliedIndex:4809; }","duration":"106.52912ms","start":"2026-06-13T01:11:16.772785Z","end":"2026-06-13T01:11:16.879314Z","steps":["trace[1538182859] 'read index received' (duration: 106.390367ms)","trace[1538182859] 'applied index is now lower than readState.Index' (duration: 137.403µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:11:16.879439Z","caller":"traceutil/trace.go:171","msg":"trace[1887689849] transaction","detail":"{read_only:false; response_revision:4625; number_of_response:1; }","duration":"154.916618ms","start":"2026-06-13T01:11:16.724492Z","end":"2026-06-13T01:11:16.879409Z","steps":["trace[1887689849] 'process raft request' (duration: 154.625033ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:16.879798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.990929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-653968f8-fc6d-4827-9a75-3ab9f8816465\" ","response":"range_response_count:1 size:3774"} {"level":"info","ts":"2026-06-13T01:11:16.87987Z","caller":"traceutil/trace.go:171","msg":"trace[591397932] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-653968f8-fc6d-4827-9a75-3ab9f8816465; range_end:; response_count:1; response_revision:4625; }","duration":"107.111421ms","start":"2026-06-13T01:11:16.772739Z","end":"2026-06-13T01:11:16.87985Z","steps":["trace[591397932] 'agreement among raft nodes before linearized reading' (duration: 106.679583ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:16.929971Z","caller":"traceutil/trace.go:171","msg":"trace[1019088590] transaction","detail":"{read_only:false; response_revision:4626; number_of_response:1; }","duration":"144.870803ms","start":"2026-06-13T01:11:16.785083Z","end":"2026-06-13T01:11:16.929953Z","steps":["trace[1019088590] 'process raft request' (duration: 144.75909ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:16.931209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.096079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:46 size:1954238"} {"level":"info","ts":"2026-06-13T01:11:16.931242Z","caller":"traceutil/trace.go:171","msg":"trace[1128187610] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:46; response_revision:4626; }","duration":"136.153171ms","start":"2026-06-13T01:11:16.795082Z","end":"2026-06-13T01:11:16.931235Z","steps":["trace[1128187610] 'agreement among raft nodes before linearized reading' (duration: 135.320316ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:16.932291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.806528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-06-13T01:11:16.932314Z","caller":"traceutil/trace.go:171","msg":"trace[287485595] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4626; }","duration":"139.844389ms","start":"2026-06-13T01:11:16.792463Z","end":"2026-06-13T01:11:16.932307Z","steps":["trace[287485595] 'agreement among raft nodes before linearized reading' (duration: 139.774227ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:16.932419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.957394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:9698"} {"level":"info","ts":"2026-06-13T01:11:16.932436Z","caller":"traceutil/trace.go:171","msg":"trace[1925690503] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:4626; }","duration":"159.012744ms","start":"2026-06-13T01:11:16.773419Z","end":"2026-06-13T01:11:16.932432Z","steps":["trace[1925690503] 'agreement among raft nodes before linearized reading' (duration: 158.960163ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:17.992957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.973585ms","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-06-13T01:11:17.993083Z","caller":"traceutil/trace.go:171","msg":"trace[166859606] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4677; }","duration":"174.168528ms","start":"2026-06-13T01:11:17.818889Z","end":"2026-06-13T01:11:17.993057Z","steps":["trace[166859606] 'range keys from in-memory index tree' (duration: 173.766272ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:17.993107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.112141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-653968f8-fc6d-4827-9a75-3ab9f8816465\" ","response":"range_response_count:1 size:3774"} {"level":"info","ts":"2026-06-13T01:11:17.993222Z","caller":"traceutil/trace.go:171","msg":"trace[409979280] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-653968f8-fc6d-4827-9a75-3ab9f8816465; range_end:; response_count:1; response_revision:4677; }","duration":"268.316335ms","start":"2026-06-13T01:11:17.724878Z","end":"2026-06-13T01:11:17.993194Z","steps":["trace[409979280] 'range keys from in-memory index tree' (duration: 267.867816ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:17.993627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.502092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2206973"} {"level":"info","ts":"2026-06-13T01:11:17.99366Z","caller":"traceutil/trace.go:171","msg":"trace[45216713] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4677; }","duration":"121.570373ms","start":"2026-06-13T01:11:17.87208Z","end":"2026-06-13T01:11:17.99365Z","steps":["trace[45216713] 'range keys from in-memory index tree' (duration: 120.719898ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:18.201186Z","caller":"traceutil/trace.go:171","msg":"trace[1997031040] transaction","detail":"{read_only:false; response_revision:4681; number_of_response:1; }","duration":"113.113331ms","start":"2026-06-13T01:11:18.088051Z","end":"2026-06-13T01:11:18.201165Z","steps":["trace[1997031040] 'process raft request' (duration: 112.768895ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:18.201436Z","caller":"traceutil/trace.go:171","msg":"trace[1664890516] transaction","detail":"{read_only:false; response_revision:4682; number_of_response:1; }","duration":"113.231904ms","start":"2026-06-13T01:11:18.088166Z","end":"2026-06-13T01:11:18.201398Z","steps":["trace[1664890516] 'process raft request' (duration: 112.776285ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:18.895868Z","caller":"traceutil/trace.go:171","msg":"trace[65466245] transaction","detail":"{read_only:false; response_revision:4689; number_of_response:1; }","duration":"103.28923ms","start":"2026-06-13T01:11:18.792558Z","end":"2026-06-13T01:11:18.895848Z","steps":["trace[65466245] 'process raft request' (duration: 103.180518ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:27.092294Z","caller":"traceutil/trace.go:171","msg":"trace[379448652] linearizableReadLoop","detail":"{readStateIndex:5008; appliedIndex:5007; }","duration":"124.338182ms","start":"2026-06-13T01:11:26.967927Z","end":"2026-06-13T01:11:27.092266Z","steps":["trace[379448652] 'read index received' (duration: 124.148559ms)","trace[379448652] 'applied index is now lower than readState.Index' (duration: 188.063µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:11:27.092402Z","caller":"traceutil/trace.go:171","msg":"trace[16446475] transaction","detail":"{read_only:false; response_revision:4816; number_of_response:1; }","duration":"129.656039ms","start":"2026-06-13T01:11:26.962709Z","end":"2026-06-13T01:11:27.092365Z","steps":["trace[16446475] 'process raft request' (duration: 129.358494ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:27.092641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.687758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12975"} {"level":"info","ts":"2026-06-13T01:11:27.09268Z","caller":"traceutil/trace.go:171","msg":"trace[2100750462] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4816; }","duration":"124.790161ms","start":"2026-06-13T01:11:26.967878Z","end":"2026-06-13T01:11:27.092669Z","steps":["trace[2100750462] 'agreement among raft nodes before linearized reading' (duration: 124.555986ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:27.814554Z","caller":"traceutil/trace.go:171","msg":"trace[569700900] transaction","detail":"{read_only:false; response_revision:4824; number_of_response:1; }","duration":"130.580255ms","start":"2026-06-13T01:11:27.68393Z","end":"2026-06-13T01:11:27.81451Z","steps":["trace[569700900] 'process raft request' (duration: 40.805839ms)","trace[569700900] 'compare' (duration: 89.567402ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:11:27.820495Z","caller":"traceutil/trace.go:171","msg":"trace[972542775] transaction","detail":"{read_only:false; response_revision:4826; number_of_response:1; }","duration":"129.832391ms","start":"2026-06-13T01:11:27.690647Z","end":"2026-06-13T01:11:27.820479Z","steps":["trace[972542775] 'process raft request' (duration: 129.80499ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:27.820544Z","caller":"traceutil/trace.go:171","msg":"trace[1500409252] transaction","detail":"{read_only:false; response_revision:4825; number_of_response:1; }","duration":"130.90957ms","start":"2026-06-13T01:11:27.689597Z","end":"2026-06-13T01:11:27.820506Z","steps":["trace[1500409252] 'process raft request' (duration: 130.732667ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:28.309227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.286713ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T01:11:28.3098Z","caller":"traceutil/trace.go:171","msg":"trace[1583663789] transaction","detail":"{read_only:false; response_revision:4830; number_of_response:1; }","duration":"247.433541ms","start":"2026-06-13T01:11:28.062348Z","end":"2026-06-13T01:11:28.309782Z","steps":["trace[1583663789] 'process raft request' (duration: 247.332179ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:28.30983Z","caller":"traceutil/trace.go:171","msg":"trace[1302263382] transaction","detail":"{read_only:false; response_revision:4829; number_of_response:1; }","duration":"247.460711ms","start":"2026-06-13T01:11:28.062339Z","end":"2026-06-13T01:11:28.3098Z","steps":["trace[1302263382] 'process raft request' (duration: 22.510277ms)","trace[1302263382] 'compare' (duration: 224.132699ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:11:28.316725Z","caller":"traceutil/trace.go:171","msg":"trace[1053737518] linearizableReadLoop","detail":"{readStateIndex:5024; appliedIndex:5020; }","duration":"250.780341ms","start":"2026-06-13T01:11:28.065926Z","end":"2026-06-13T01:11:28.316707Z","steps":["trace[1053737518] 'read index received' (duration: 18.896321ms)","trace[1053737518] 'applied index is now lower than readState.Index' (duration: 231.88289ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:11:28.317046Z","caller":"traceutil/trace.go:171","msg":"trace[1281099065] transaction","detail":"{read_only:false; response_revision:4831; number_of_response:1; }","duration":"253.037841ms","start":"2026-06-13T01:11:28.063993Z","end":"2026-06-13T01:11:28.317031Z","steps":["trace[1281099065] 'process raft request' (duration: 252.574383ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:28.317815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.85045ms","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-06-13T01:11:28.31801Z","caller":"traceutil/trace.go:171","msg":"trace[944824151] 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:4832; }","duration":"252.099615ms","start":"2026-06-13T01:11:28.065881Z","end":"2026-06-13T01:11:28.317981Z","steps":["trace[944824151] 'agreement among raft nodes before linearized reading' (duration: 251.670848ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:28.317926Z","caller":"traceutil/trace.go:171","msg":"trace[277456909] transaction","detail":"{read_only:false; response_revision:4832; number_of_response:1; }","duration":"253.862977ms","start":"2026-06-13T01:11:28.064044Z","end":"2026-06-13T01:11:28.317907Z","steps":["trace[277456909] 'process raft request' (duration: 252.606744ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:28.319037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.054373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-13T01:11:28.319108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.059735ms","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-06-13T01:11:28.319151Z","caller":"traceutil/trace.go:171","msg":"trace[684824217] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4833; }","duration":"117.148127ms","start":"2026-06-13T01:11:28.201991Z","end":"2026-06-13T01:11:28.31914Z","steps":["trace[684824217] 'agreement among raft nodes before linearized reading' (duration: 117.055985ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:28.319115Z","caller":"traceutil/trace.go:171","msg":"trace[1530793547] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4833; }","duration":"190.183146ms","start":"2026-06-13T01:11:28.128918Z","end":"2026-06-13T01:11:28.319101Z","steps":["trace[1530793547] 'agreement among raft nodes before linearized reading' (duration: 190.026463ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:29.964795Z","caller":"traceutil/trace.go:171","msg":"trace[263579212] transaction","detail":"{read_only:false; response_revision:4848; number_of_response:1; }","duration":"109.355959ms","start":"2026-06-13T01:11:29.855419Z","end":"2026-06-13T01:11:29.964775Z","steps":["trace[263579212] 'process raft request' (duration: 108.684886ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:29.965066Z","caller":"traceutil/trace.go:171","msg":"trace[2012093482] transaction","detail":"{read_only:false; response_revision:4849; number_of_response:1; }","duration":"109.634644ms","start":"2026-06-13T01:11:29.855422Z","end":"2026-06-13T01:11:29.965057Z","steps":["trace[2012093482] 'process raft request' (duration: 109.322618ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:29.965023Z","caller":"traceutil/trace.go:171","msg":"trace[762995377] linearizableReadLoop","detail":"{readStateIndex:5041; appliedIndex:5038; }","duration":"100.407068ms","start":"2026-06-13T01:11:29.864589Z","end":"2026-06-13T01:11:29.964996Z","steps":["trace[762995377] 'read index received' (duration: 66.975146ms)","trace[762995377] 'applied index is now lower than readState.Index' (duration: 33.430422ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T01:11:29.965205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.586711ms","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-06-13T01:11:29.965244Z","caller":"traceutil/trace.go:171","msg":"trace[1909624245] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:4849; }","duration":"100.674172ms","start":"2026-06-13T01:11:29.864555Z","end":"2026-06-13T01:11:29.96523Z","steps":["trace[1909624245] 'agreement among raft nodes before linearized reading' (duration: 100.58691ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:32.852877Z","caller":"traceutil/trace.go:171","msg":"trace[34459251] linearizableReadLoop","detail":"{readStateIndex:5082; appliedIndex:5081; }","duration":"136.350351ms","start":"2026-06-13T01:11:32.716507Z","end":"2026-06-13T01:11:32.852857Z","steps":["trace[34459251] 'read index received' (duration: 106.153371ms)","trace[34459251] 'applied index is now lower than readState.Index' (duration: 30.19589ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:11:32.853075Z","caller":"traceutil/trace.go:171","msg":"trace[1136489760] transaction","detail":"{read_only:false; response_revision:4888; number_of_response:1; }","duration":"136.86585ms","start":"2026-06-13T01:11:32.716194Z","end":"2026-06-13T01:11:32.85306Z","steps":["trace[1136489760] 'process raft request' (duration: 106.600339ms)","trace[1136489760] 'compare' (duration: 29.731181ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T01:11:32.853392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.866911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-06-13T01:11:32.853432Z","caller":"traceutil/trace.go:171","msg":"trace[349694040] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4888; }","duration":"136.938112ms","start":"2026-06-13T01:11:32.716484Z","end":"2026-06-13T01:11:32.853422Z","steps":["trace[349694040] 'agreement among raft nodes before linearized reading' (duration: 136.781389ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:32.853625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.083574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-06-13T01:11:32.853656Z","caller":"traceutil/trace.go:171","msg":"trace[1624103879] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4888; }","duration":"137.122646ms","start":"2026-06-13T01:11:32.716526Z","end":"2026-06-13T01:11:32.853649Z","steps":["trace[1624103879] 'agreement among raft nodes before linearized reading' (duration: 137.045064ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:32.853888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.817235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T01:11:32.853925Z","caller":"traceutil/trace.go:171","msg":"trace[1367676685] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:4888; }","duration":"110.882285ms","start":"2026-06-13T01:11:32.743034Z","end":"2026-06-13T01:11:32.853916Z","steps":["trace[1367676685] 'agreement among raft nodes before linearized reading' (duration: 110.821674ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:32.854091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.380663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" ","response":"range_response_count:1 size:2264"} {"level":"info","ts":"2026-06-13T01:11:32.854125Z","caller":"traceutil/trace.go:171","msg":"trace[175282547] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls; range_end:; response_count:1; response_revision:4888; }","duration":"135.425065ms","start":"2026-06-13T01:11:32.718692Z","end":"2026-06-13T01:11:32.854117Z","steps":["trace[175282547] 'agreement among raft nodes before linearized reading' (duration: 135.333443ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:34.146374Z","caller":"traceutil/trace.go:171","msg":"trace[262674486] transaction","detail":"{read_only:false; response_revision:4937; number_of_response:1; }","duration":"106.282265ms","start":"2026-06-13T01:11:34.04007Z","end":"2026-06-13T01:11:34.146352Z","steps":["trace[262674486] 'process raft request' (duration: 98.202581ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:34.146444Z","caller":"traceutil/trace.go:171","msg":"trace[1651175269] linearizableReadLoop","detail":"{readStateIndex:5133; appliedIndex:5131; }","duration":"100.844608ms","start":"2026-06-13T01:11:34.045452Z","end":"2026-06-13T01:11:34.146296Z","steps":["trace[1651175269] 'read index received' (duration: 92.850826ms)","trace[1651175269] 'applied index is now lower than readState.Index' (duration: 7.993222ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:11:34.146571Z","caller":"traceutil/trace.go:171","msg":"trace[1211642557] transaction","detail":"{read_only:false; response_revision:4938; number_of_response:1; }","duration":"105.453ms","start":"2026-06-13T01:11:34.041097Z","end":"2026-06-13T01:11:34.14655Z","steps":["trace[1211642557] 'process raft request' (duration: 105.119044ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:34.148196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.705122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-06-13T01:11:34.148595Z","caller":"traceutil/trace.go:171","msg":"trace[1187173223] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4938; }","duration":"103.137379ms","start":"2026-06-13T01:11:34.045448Z","end":"2026-06-13T01:11:34.148585Z","steps":["trace[1187173223] 'agreement among raft nodes before linearized reading' (duration: 101.041252ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:35.457866Z","caller":"traceutil/trace.go:171","msg":"trace[63337670] transaction","detail":"{read_only:false; response_revision:4993; number_of_response:1; }","duration":"404.183919ms","start":"2026-06-13T01:11:35.053654Z","end":"2026-06-13T01:11:35.457838Z","steps":["trace[63337670] 'process raft request' (duration: 404.021716ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:35.45824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:11:35.053644Z","time spent":"404.498555ms","remote":"127.0.0.1:46014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3751,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T01:11:36.371698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.863221ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T01:11:36.371828Z","caller":"traceutil/trace.go:171","msg":"trace[1302474221] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:4993; }","duration":"323.005514ms","start":"2026-06-13T01:11:36.048806Z","end":"2026-06-13T01:11:36.371811Z","steps":["trace[1302474221] 'range keys from in-memory index tree' (duration: 322.850961ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:36.372143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"701.574894ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-13T01:11:36.372242Z","caller":"traceutil/trace.go:171","msg":"trace[1017839967] transaction","detail":"{read_only:false; response_revision:4994; number_of_response:1; }","duration":"1.314254632s","start":"2026-06-13T01:11:35.057956Z","end":"2026-06-13T01:11:36.372211Z","steps":["trace[1017839967] 'process raft request' (duration: 612.549625ms)","trace[1017839967] 'compare' (duration: 701.080116ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T01:11:36.372625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.253693236s","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-06-13T01:11:36.372666Z","caller":"traceutil/trace.go:171","msg":"trace[1540032396] 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:4995; }","duration":"1.253869469s","start":"2026-06-13T01:11:35.118785Z","end":"2026-06-13T01:11:36.372654Z","steps":["trace[1540032396] 'agreement among raft nodes before linearized reading' (duration: 1.253667865s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:36.372694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:11:35.118769Z","time spent":"1.253915909s","remote":"127.0.0.1:45976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2105,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"warn","ts":"2026-06-13T01:11:36.372703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:11:35.057939Z","time spent":"1.314693909s","remote":"127.0.0.1:45890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":878,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-13T01:11:36.372394Z","caller":"traceutil/trace.go:171","msg":"trace[1576830097] linearizableReadLoop","detail":"{readStateIndex:5189; appliedIndex:5187; }","duration":"1.253504153s","start":"2026-06-13T01:11:35.118868Z","end":"2026-06-13T01:11:36.372372Z","steps":["trace[1576830097] 'read index received' (duration: 338.760736ms)","trace[1576830097] 'applied index is now lower than readState.Index' (duration: 914.720046ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:11:36.372427Z","caller":"traceutil/trace.go:171","msg":"trace[137887455] transaction","detail":"{read_only:false; response_revision:4995; number_of_response:1; }","duration":"889.418456ms","start":"2026-06-13T01:11:35.482993Z","end":"2026-06-13T01:11:36.372412Z","steps":["trace[137887455] 'process raft request' (duration: 889.231053ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:36.372954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:11:35.482976Z","time spent":"889.913905ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T01:11:36.598281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.291918ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T01:11:36.598511Z","caller":"traceutil/trace.go:171","msg":"trace[137774870] linearizableReadLoop","detail":"{readStateIndex:5195; appliedIndex:5190; }","duration":"225.684986ms","start":"2026-06-13T01:11:36.372811Z","end":"2026-06-13T01:11:36.598496Z","steps":["trace[137774870] 'read index received' (duration: 120.069282ms)","trace[137774870] 'applied index is now lower than readState.Index' (duration: 105.614864ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T01:11:36.598662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.932945ms","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-06-13T01:11:36.598681Z","caller":"traceutil/trace.go:171","msg":"trace[1572550250] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5001; }","duration":"232.997806ms","start":"2026-06-13T01:11:36.365677Z","end":"2026-06-13T01:11:36.598675Z","steps":["trace[1572550250] 'agreement among raft nodes before linearized reading' (duration: 232.891695ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:36.598843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.163558753s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-13T01:11:36.598789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.856296ms","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-06-13T01:11:36.598917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.268785015s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b261151e-61a6-48da-b239-ed3f74d5c28f\" ","response":"range_response_count:1 size:3766"} {"level":"info","ts":"2026-06-13T01:11:36.598917Z","caller":"traceutil/trace.go:171","msg":"trace[2070924678] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5001; }","duration":"232.009858ms","start":"2026-06-13T01:11:36.366873Z","end":"2026-06-13T01:11:36.598883Z","steps":["trace[2070924678] 'agreement among raft nodes before linearized reading' (duration: 231.694983ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:36.598937Z","caller":"traceutil/trace.go:171","msg":"trace[1082196613] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b261151e-61a6-48da-b239-ed3f74d5c28f; range_end:; response_count:1; response_revision:5001; }","duration":"1.268827825s","start":"2026-06-13T01:11:35.330105Z","end":"2026-06-13T01:11:36.598933Z","steps":["trace[1082196613] 'agreement among raft nodes before linearized reading' (duration: 1.268767094s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:36.598953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:11:35.330092Z","time spent":"1.268856616s","remote":"127.0.0.1:46014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3789,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b261151e-61a6-48da-b239-ed3f74d5c28f\" "} {"level":"warn","ts":"2026-06-13T01:11:36.59907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.744065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-f258677d-9762-481f-9c99-bee67d856e5c\" ","response":"range_response_count:1 size:1435"} {"level":"info","ts":"2026-06-13T01:11:36.599089Z","caller":"traceutil/trace.go:171","msg":"trace[768335462] range","detail":"{range_begin:/registry/persistentvolumes/pvc-f258677d-9762-481f-9c99-bee67d856e5c; range_end:; response_count:1; response_revision:5001; }","duration":"221.786557ms","start":"2026-06-13T01:11:36.377297Z","end":"2026-06-13T01:11:36.599084Z","steps":["trace[768335462] 'agreement among raft nodes before linearized reading' (duration: 221.736456ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:36.599234Z","caller":"traceutil/trace.go:171","msg":"trace[1235319424] transaction","detail":"{read_only:false; response_revision:5000; number_of_response:1; }","duration":"440.789554ms","start":"2026-06-13T01:11:36.158431Z","end":"2026-06-13T01:11:36.59922Z","steps":["trace[1235319424] 'process raft request' (duration: 440.00838ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:36.599344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:11:36.158408Z","time spent":"440.862855ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T01:11:36.599521Z","caller":"traceutil/trace.go:171","msg":"trace[1731245303] transaction","detail":"{read_only:false; response_revision:5001; number_of_response:1; }","duration":"222.135982ms","start":"2026-06-13T01:11:36.377374Z","end":"2026-06-13T01:11:36.59951Z","steps":["trace[1731245303] 'process raft request' (duration: 221.084634ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:36.599555Z","caller":"traceutil/trace.go:171","msg":"trace[1079847696] transaction","detail":"{read_only:false; response_revision:4997; number_of_response:1; }","duration":"650.325834ms","start":"2026-06-13T01:11:35.949222Z","end":"2026-06-13T01:11:36.599548Z","steps":["trace[1079847696] 'process raft request' (duration: 649.133223ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:36.599591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:11:35.949196Z","time spent":"650.375035ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T01:11:36.599475Z","caller":"traceutil/trace.go:171","msg":"trace[210127064] transaction","detail":"{read_only:false; response_revision:4999; number_of_response:1; }","duration":"616.780557ms","start":"2026-06-13T01:11:35.982324Z","end":"2026-06-13T01:11:36.599104Z","steps":["trace[210127064] 'process raft request' (duration: 616.085475ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:36.599748Z","caller":"traceutil/trace.go:171","msg":"trace[2108973723] transaction","detail":"{read_only:false; response_revision:4998; number_of_response:1; }","duration":"617.896967ms","start":"2026-06-13T01:11:35.981846Z","end":"2026-06-13T01:11:36.599743Z","steps":["trace[2108973723] 'process raft request' (duration: 616.540403ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:36.598863Z","caller":"traceutil/trace.go:171","msg":"trace[726984815] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:5001; }","duration":"1.163623145s","start":"2026-06-13T01:11:35.435235Z","end":"2026-06-13T01:11:36.598859Z","steps":["trace[726984815] 'agreement among raft nodes before linearized reading' (duration: 1.163584904s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:36.599783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:11:35.981832Z","time spent":"617.932978ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T01:11:36.599785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:11:35.435209Z","time spent":"1.164563622s","remote":"127.0.0.1:56416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-13T01:11:36.599737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.828473ms","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-06-13T01:11:36.599863Z","caller":"traceutil/trace.go:171","msg":"trace[36514195] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5001; }","duration":"232.988335ms","start":"2026-06-13T01:11:36.366868Z","end":"2026-06-13T01:11:36.599857Z","steps":["trace[36514195] 'agreement among raft nodes before linearized reading' (duration: 232.790602ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:36.600252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.154547ms","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-06-13T01:11:36.600276Z","caller":"traceutil/trace.go:171","msg":"trace[1074300825] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5001; }","duration":"242.257289ms","start":"2026-06-13T01:11:36.358011Z","end":"2026-06-13T01:11:36.600269Z","steps":["trace[1074300825] 'agreement among raft nodes before linearized reading' (duration: 242.201108ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:36.600343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.303211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-13T01:11:36.600396Z","caller":"traceutil/trace.go:171","msg":"trace[1293807511] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5001; }","duration":"237.398972ms","start":"2026-06-13T01:11:36.362982Z","end":"2026-06-13T01:11:36.600381Z","steps":["trace[1293807511] 'agreement among raft nodes before linearized reading' (duration: 237.29018ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:36.600414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.297829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.227\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-13T01:11:36.600428Z","caller":"traceutil/trace.go:171","msg":"trace[530734051] range","detail":"{range_begin:/registry/masterleases/199.204.45.227; range_end:; response_count:1; response_revision:5001; }","duration":"380.342571ms","start":"2026-06-13T01:11:36.220081Z","end":"2026-06-13T01:11:36.600423Z","steps":["trace[530734051] 'agreement among raft nodes before linearized reading' (duration: 380.30063ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:36.600446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:11:36.220065Z","time spent":"380.378191ms","remote":"127.0.0.1:45834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.227\" "} {"level":"warn","ts":"2026-06-13T01:11:36.600516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.137290186s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16548"} {"level":"info","ts":"2026-06-13T01:11:36.59967Z","caller":"traceutil/trace.go:171","msg":"trace[1338818901] transaction","detail":"{read_only:false; response_revision:4996; number_of_response:1; }","duration":"775.99313ms","start":"2026-06-13T01:11:35.823669Z","end":"2026-06-13T01:11:36.599662Z","steps":["trace[1338818901] 'process raft request' (duration: 669.246885ms)","trace[1338818901] 'compare' (duration: 105.034794ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T01:11:36.600753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:11:35.982306Z","time spent":"617.768884ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T01:11:36.600832Z","caller":"traceutil/trace.go:171","msg":"trace[1240558248] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5001; }","duration":"1.138281233s","start":"2026-06-13T01:11:35.462391Z","end":"2026-06-13T01:11:36.600672Z","steps":["trace[1240558248] 'agreement among raft nodes before linearized reading' (duration: 1.136212137s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:36.600959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:11:35.823644Z","time spent":"777.18548ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T01:11:36.600869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:11:35.462374Z","time spent":"1.138487666s","remote":"127.0.0.1:46014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":16571,"request content":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"info","ts":"2026-06-13T01:11:42.958529Z","caller":"traceutil/trace.go:171","msg":"trace[1067009986] transaction","detail":"{read_only:false; response_revision:5072; number_of_response:1; }","duration":"162.614638ms","start":"2026-06-13T01:11:42.79589Z","end":"2026-06-13T01:11:42.958505Z","steps":["trace[1067009986] 'process raft request' (duration: 162.321813ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:42.985345Z","caller":"traceutil/trace.go:171","msg":"trace[2014462781] transaction","detail":"{read_only:false; response_revision:5073; number_of_response:1; }","duration":"189.176904ms","start":"2026-06-13T01:11:42.796128Z","end":"2026-06-13T01:11:42.985305Z","steps":["trace[2014462781] 'process raft request' (duration: 188.906469ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:42.985351Z","caller":"traceutil/trace.go:171","msg":"trace[407963163] transaction","detail":"{read_only:false; response_revision:5074; number_of_response:1; }","duration":"189.117873ms","start":"2026-06-13T01:11:42.796198Z","end":"2026-06-13T01:11:42.985316Z","steps":["trace[407963163] 'process raft request' (duration: 188.989081ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:42.98611Z","caller":"traceutil/trace.go:171","msg":"trace[1704651905] transaction","detail":"{read_only:false; response_revision:5075; number_of_response:1; }","duration":"189.311937ms","start":"2026-06-13T01:11:42.796783Z","end":"2026-06-13T01:11:42.986094Z","steps":["trace[1704651905] 'process raft request' (duration: 188.472832ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:42.986376Z","caller":"traceutil/trace.go:171","msg":"trace[1120497596] transaction","detail":"{read_only:false; response_revision:5076; number_of_response:1; }","duration":"189.230846ms","start":"2026-06-13T01:11:42.797135Z","end":"2026-06-13T01:11:42.986366Z","steps":["trace[1120497596] 'process raft request' (duration: 188.90372ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:48.420841Z","caller":"traceutil/trace.go:171","msg":"trace[92621648] transaction","detail":"{read_only:false; response_revision:5102; number_of_response:1; }","duration":"242.542178ms","start":"2026-06-13T01:11:48.178263Z","end":"2026-06-13T01:11:48.420805Z","steps":["trace[92621648] 'process raft request' (duration: 242.308874ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:48.421145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.172584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-06-13T01:11:48.421263Z","caller":"traceutil/trace.go:171","msg":"trace[1854792257] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5102; }","duration":"222.333247ms","start":"2026-06-13T01:11:48.198913Z","end":"2026-06-13T01:11:48.421246Z","steps":["trace[1854792257] 'agreement among raft nodes before linearized reading' (duration: 221.973461ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:48.420822Z","caller":"traceutil/trace.go:171","msg":"trace[245505641] linearizableReadLoop","detail":"{readStateIndex:5300; appliedIndex:5299; }","duration":"221.807928ms","start":"2026-06-13T01:11:48.198955Z","end":"2026-06-13T01:11:48.420763Z","steps":["trace[245505641] 'read index received' (duration: 221.671016ms)","trace[245505641] 'applied index is now lower than readState.Index' (duration: 135.722µs)"],"step_count":2} {"level":"warn","ts":"2026-06-13T01:11:48.695944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.508943ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T01:11:48.696209Z","caller":"traceutil/trace.go:171","msg":"trace[290633164] transaction","detail":"{read_only:false; response_revision:5104; number_of_response:1; }","duration":"265.061928ms","start":"2026-06-13T01:11:48.431102Z","end":"2026-06-13T01:11:48.696164Z","steps":["trace[290633164] 'process raft request' (duration: 86.847093ms)","trace[290633164] 'compare' (duration: 177.34256ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:11:48.696487Z","caller":"traceutil/trace.go:171","msg":"trace[360570315] transaction","detail":"{read_only:false; response_revision:5106; number_of_response:1; }","duration":"264.443846ms","start":"2026-06-13T01:11:48.431928Z","end":"2026-06-13T01:11:48.696372Z","steps":["trace[360570315] 'process raft request' (duration: 264.287084ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:48.696507Z","caller":"traceutil/trace.go:171","msg":"trace[2100626154] transaction","detail":"{read_only:false; response_revision:5105; number_of_response:1; }","duration":"265.286331ms","start":"2026-06-13T01:11:48.431198Z","end":"2026-06-13T01:11:48.696484Z","steps":["trace[2100626154] 'process raft request' (duration: 264.873094ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:48.696864Z","caller":"traceutil/trace.go:171","msg":"trace[254654897] linearizableReadLoop","detail":"{readStateIndex:5305; appliedIndex:5301; }","duration":"242.936753ms","start":"2026-06-13T01:11:48.453915Z","end":"2026-06-13T01:11:48.696851Z","steps":["trace[254654897] 'read index received' (duration: 63.922685ms)","trace[254654897] 'applied index is now lower than readState.Index' (duration: 179.012888ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T01:11:48.69705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.43592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-b261151e-61a6-48da-b239-ed3f74d5c28f\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-06-13T01:11:48.697091Z","caller":"traceutil/trace.go:171","msg":"trace[1849803152] range","detail":"{range_begin:/registry/persistentvolumes/pvc-b261151e-61a6-48da-b239-ed3f74d5c28f; range_end:; response_count:1; response_revision:5107; }","duration":"270.520801ms","start":"2026-06-13T01:11:48.426555Z","end":"2026-06-13T01:11:48.697076Z","steps":["trace[1849803152] 'agreement among raft nodes before linearized reading' (duration: 270.345208ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:48.697129Z","caller":"traceutil/trace.go:171","msg":"trace[1118277544] transaction","detail":"{read_only:false; response_revision:5107; number_of_response:1; }","duration":"264.172322ms","start":"2026-06-13T01:11:48.432926Z","end":"2026-06-13T01:11:48.697098Z","steps":["trace[1118277544] 'process raft request' (duration: 263.375608ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:11:48.697919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.811679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10682"} {"level":"info","ts":"2026-06-13T01:11:48.698035Z","caller":"traceutil/trace.go:171","msg":"trace[706572446] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5107; }","duration":"266.975591ms","start":"2026-06-13T01:11:48.431031Z","end":"2026-06-13T01:11:48.698007Z","steps":["trace[706572446] 'agreement among raft nodes before linearized reading' (duration: 266.248878ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:11:48.852083Z","caller":"traceutil/trace.go:171","msg":"trace[112484527] transaction","detail":"{read_only:false; response_revision:5109; number_of_response:1; }","duration":"183.084249ms","start":"2026-06-13T01:11:48.66897Z","end":"2026-06-13T01:11:48.852054Z","steps":["trace[112484527] 'process raft request' (duration: 130.901936ms)","trace[112484527] 'compare' (duration: 52.01314ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:11:48.852233Z","caller":"traceutil/trace.go:171","msg":"trace[115198070] transaction","detail":"{read_only:false; response_revision:5110; number_of_response:1; }","duration":"183.11327ms","start":"2026-06-13T01:11:48.669089Z","end":"2026-06-13T01:11:48.852202Z","steps":["trace[115198070] 'process raft request' (duration: 182.923816ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:12:17.420045Z","caller":"traceutil/trace.go:171","msg":"trace[486301124] transaction","detail":"{read_only:false; response_revision:5374; number_of_response:1; }","duration":"193.677556ms","start":"2026-06-13T01:12:17.226343Z","end":"2026-06-13T01:12:17.42002Z","steps":["trace[486301124] 'process raft request' (duration: 193.282759ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:12:21.121453Z","caller":"traceutil/trace.go:171","msg":"trace[771106452] transaction","detail":"{read_only:false; response_revision:5390; number_of_response:1; }","duration":"225.091898ms","start":"2026-06-13T01:12:20.896333Z","end":"2026-06-13T01:12:21.121425Z","steps":["trace[771106452] 'process raft request' (duration: 224.955806ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:12:21.238392Z","caller":"traceutil/trace.go:171","msg":"trace[695265246] transaction","detail":"{read_only:false; response_revision:5392; number_of_response:1; }","duration":"215.342827ms","start":"2026-06-13T01:12:21.023013Z","end":"2026-06-13T01:12:21.238356Z","steps":["trace[695265246] 'process raft request' (duration: 215.289976ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:12:21.238429Z","caller":"traceutil/trace.go:171","msg":"trace[1962952247] transaction","detail":"{read_only:false; response_revision:5391; number_of_response:1; }","duration":"240.835682ms","start":"2026-06-13T01:12:20.997569Z","end":"2026-06-13T01:12:21.238405Z","steps":["trace[1962952247] 'process raft request' (duration: 236.005914ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:12:27.571907Z","caller":"traceutil/trace.go:171","msg":"trace[829287084] transaction","detail":"{read_only:false; response_revision:5430; number_of_response:1; }","duration":"109.242332ms","start":"2026-06-13T01:12:27.462626Z","end":"2026-06-13T01:12:27.571868Z","steps":["trace[829287084] 'process raft request' (duration: 108.928606ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:12:27.958789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.122737ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T01:12:27.958966Z","caller":"traceutil/trace.go:171","msg":"trace[2085596320] transaction","detail":"{read_only:false; response_revision:5435; number_of_response:1; }","duration":"219.592812ms","start":"2026-06-13T01:12:27.739359Z","end":"2026-06-13T01:12:27.958952Z","steps":["trace[2085596320] 'process raft request' (duration: 47.237362ms)","trace[2085596320] 'compare' (duration: 172.029445ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:12:28.026789Z","caller":"traceutil/trace.go:171","msg":"trace[616277545] transaction","detail":"{read_only:false; response_revision:5436; number_of_response:1; }","duration":"170.999407ms","start":"2026-06-13T01:12:27.855758Z","end":"2026-06-13T01:12:28.026757Z","steps":["trace[616277545] 'process raft request' (duration: 170.816884ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:12:33.122021Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2871} {"level":"info","ts":"2026-06-13T01:12:33.222441Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2871,"took":"98.975202ms","hash":2193769554,"current-db-size-bytes":51544064,"current-db-size":"52 MB","current-db-size-in-use-bytes":28700672,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-13T01:12:33.222499Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2193769554,"revision":2871,"compact-revision":-1} {"level":"info","ts":"2026-06-13T01:12:37.477329Z","caller":"traceutil/trace.go:171","msg":"trace[89343476] transaction","detail":"{read_only:false; response_revision:5505; number_of_response:1; }","duration":"185.80819ms","start":"2026-06-13T01:12:37.291477Z","end":"2026-06-13T01:12:37.477285Z","steps":["trace[89343476] 'process raft request' (duration: 89.42286ms)","trace[89343476] 'compare' (duration: 96.162257ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:12:37.47735Z","caller":"traceutil/trace.go:171","msg":"trace[1267757213] transaction","detail":"{read_only:false; response_revision:5506; number_of_response:1; }","duration":"181.312149ms","start":"2026-06-13T01:12:37.296007Z","end":"2026-06-13T01:12:37.477319Z","steps":["trace[1267757213] 'process raft request' (duration: 181.198357ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:12:43.028537Z","caller":"traceutil/trace.go:171","msg":"trace[523054845] transaction","detail":"{read_only:false; response_revision:5541; number_of_response:1; }","duration":"295.243853ms","start":"2026-06-13T01:12:42.733263Z","end":"2026-06-13T01:12:43.028507Z","steps":["trace[523054845] 'process raft request' (duration: 210.544869ms)","trace[523054845] 'compare' (duration: 84.587742ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:12:45.728044Z","caller":"traceutil/trace.go:171","msg":"trace[952220080] transaction","detail":"{read_only:false; response_revision:5559; number_of_response:1; }","duration":"104.109734ms","start":"2026-06-13T01:12:45.623899Z","end":"2026-06-13T01:12:45.728008Z","steps":["trace[952220080] 'process raft request' (duration: 103.88605ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:15:21.070266Z","caller":"traceutil/trace.go:171","msg":"trace[379371517] linearizableReadLoop","detail":"{readStateIndex:6888; appliedIndex:6887; }","duration":"341.300527ms","start":"2026-06-13T01:15:20.728931Z","end":"2026-06-13T01:15:21.070232Z","steps":["trace[379371517] 'read index received' (duration: 338.956676ms)","trace[379371517] 'applied index is now lower than readState.Index' (duration: 2.341921ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:15:21.070379Z","caller":"traceutil/trace.go:171","msg":"trace[1741903932] transaction","detail":"{read_only:false; response_revision:6640; number_of_response:1; }","duration":"454.883001ms","start":"2026-06-13T01:15:20.615467Z","end":"2026-06-13T01:15:21.07035Z","steps":["trace[1741903932] 'process raft request' (duration: 452.435338ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:15:21.070464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.52568ms","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-06-13T01:15:21.070508Z","caller":"traceutil/trace.go:171","msg":"trace[1942182095] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6640; }","duration":"341.635852ms","start":"2026-06-13T01:15:20.728862Z","end":"2026-06-13T01:15:21.070498Z","steps":["trace[1942182095] 'agreement among raft nodes before linearized reading' (duration: 341.52247ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:15:21.070617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:15:20.728833Z","time spent":"341.707693ms","remote":"127.0.0.1:46098","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-06-13T01:15:21.070634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T01:15:20.615441Z","time spent":"455.005902ms","remote":"127.0.0.1:46098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T01:15:21.070635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.168773ms","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-06-13T01:15:21.070693Z","caller":"traceutil/trace.go:171","msg":"trace[1223655311] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6640; }","duration":"280.257144ms","start":"2026-06-13T01:15:20.790421Z","end":"2026-06-13T01:15:21.070678Z","steps":["trace[1223655311] 'agreement among raft nodes before linearized reading' (duration: 280.139872ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T01:15:21.070696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.253396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-13T01:15:21.070842Z","caller":"traceutil/trace.go:171","msg":"trace[1246576023] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6640; }","duration":"278.428829ms","start":"2026-06-13T01:15:20.792358Z","end":"2026-06-13T01:15:21.070787Z","steps":["trace[1246576023] 'agreement among raft nodes before linearized reading' (duration: 278.220795ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:15:21.19575Z","caller":"traceutil/trace.go:171","msg":"trace[1554858352] transaction","detail":"{read_only:false; response_revision:6643; number_of_response:1; }","duration":"116.478492ms","start":"2026-06-13T01:15:21.07924Z","end":"2026-06-13T01:15:21.195719Z","steps":["trace[1554858352] 'process raft request' (duration: 116.415671ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:15:21.19584Z","caller":"traceutil/trace.go:171","msg":"trace[875419287] transaction","detail":"{read_only:false; response_revision:6641; number_of_response:1; }","duration":"119.848949ms","start":"2026-06-13T01:15:21.075947Z","end":"2026-06-13T01:15:21.195796Z","steps":["trace[875419287] 'process raft request' (duration: 104.330307ms)","trace[875419287] 'compare' (duration: 15.053416ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:15:21.195876Z","caller":"traceutil/trace.go:171","msg":"trace[1924336735] transaction","detail":"{read_only:false; response_revision:6642; number_of_response:1; }","duration":"119.810129ms","start":"2026-06-13T01:15:21.076026Z","end":"2026-06-13T01:15:21.195836Z","steps":["trace[1924336735] 'process raft request' (duration: 119.539015ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:15:26.253628Z","caller":"traceutil/trace.go:171","msg":"trace[179566546] transaction","detail":"{read_only:false; response_revision:6666; number_of_response:1; }","duration":"186.769578ms","start":"2026-06-13T01:15:26.066837Z","end":"2026-06-13T01:15:26.253607Z","steps":["trace[179566546] 'process raft request' (duration: 186.499014ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:15:27.284376Z","caller":"traceutil/trace.go:171","msg":"trace[1734922415] transaction","detail":"{read_only:false; response_revision:6672; number_of_response:1; }","duration":"172.545963ms","start":"2026-06-13T01:15:27.111462Z","end":"2026-06-13T01:15:27.284008Z","steps":["trace[1734922415] 'process raft request' (duration: 172.38174ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:15:27.401452Z","caller":"traceutil/trace.go:171","msg":"trace[1682212680] transaction","detail":"{read_only:false; response_revision:6675; number_of_response:1; }","duration":"110.925262ms","start":"2026-06-13T01:15:27.29051Z","end":"2026-06-13T01:15:27.401435Z","steps":["trace[1682212680] 'process raft request' (duration: 110.898382ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:15:27.40227Z","caller":"traceutil/trace.go:171","msg":"trace[529683577] transaction","detail":"{read_only:false; response_revision:6673; number_of_response:1; }","duration":"113.750011ms","start":"2026-06-13T01:15:27.288504Z","end":"2026-06-13T01:15:27.402254Z","steps":["trace[529683577] 'process raft request' (duration: 86.136804ms)","trace[529683577] 'compare' (duration: 26.644823ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T01:15:27.402295Z","caller":"traceutil/trace.go:171","msg":"trace[1152243605] transaction","detail":"{read_only:false; response_revision:6674; number_of_response:1; }","duration":"113.007741ms","start":"2026-06-13T01:15:27.289276Z","end":"2026-06-13T01:15:27.402283Z","steps":["trace[1152243605] 'process raft request' (duration: 112.102298ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:15:29.397525Z","caller":"traceutil/trace.go:171","msg":"trace[1725994091] transaction","detail":"{read_only:false; response_revision:6685; number_of_response:1; }","duration":"104.629174ms","start":"2026-06-13T01:15:29.292875Z","end":"2026-06-13T01:15:29.397505Z","steps":["trace[1725994091] 'process raft request' (duration: 104.452672ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T01:17:33.129002Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5477} {"level":"info","ts":"2026-06-13T01:17:33.229408Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5477,"took":"98.89521ms","hash":1835344980,"current-db-size-bytes":51544064,"current-db-size":"52 MB","current-db-size-in-use-bytes":18530304,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-13T01:17:33.229477Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1835344980,"revision":5477,"compact-revision":2871}