{"level":"warn","ts":"2026-07-27T10:44:52.611012Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-27T10:44:52.611098Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.219:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.219:2380","--initial-cluster=instance=https://199.19.213.219:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.219:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.219: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-07-27T10:44:52.61118Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-27T10:44:52.611192Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.219:2380"]} {"level":"info","ts":"2026-07-27T10:44:52.61121Z","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-07-27T10:44:52.611864Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.219:2379"]} {"level":"info","ts":"2026-07-27T10:44:52.611949Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.219:2380"],"listen-peer-urls":["https://199.19.213.219:2380"],"advertise-client-urls":["https://199.19.213.219:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.219:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.219: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-07-27T10:44:52.616082Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.946842ms"} {"level":"info","ts":"2026-07-27T10:44:52.624233Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"7e142186203fa167","cluster-id":"e7586aea7e662ee6"} {"level":"info","ts":"2026-07-27T10:44:52.624321Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 switched to configuration voters=()"} {"level":"info","ts":"2026-07-27T10:44:52.624348Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 became follower at term 0"} {"level":"info","ts":"2026-07-27T10:44:52.624362Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 7e142186203fa167 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-27T10:44:52.624373Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 became follower at term 1"} {"level":"info","ts":"2026-07-27T10:44:52.624431Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 switched to configuration voters=(9084923208263508327)"} {"level":"warn","ts":"2026-07-27T10:44:52.630686Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-27T10:44:52.634091Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-27T10:44:52.635224Z","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-07-27T10:44:52.638391Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"7e142186203fa167","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-27T10:44:52.638487Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"7e142186203fa167","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-27T10:44:52.639027Z","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-07-27T10:44:52.639353Z","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-07-27T10:44:52.639387Z","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-07-27T10:44:52.639597Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 switched to configuration voters=(9084923208263508327)"} {"level":"info","ts":"2026-07-27T10:44:52.64562Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e7586aea7e662ee6","local-member-id":"7e142186203fa167","added-peer-id":"7e142186203fa167","added-peer-peer-urls":["https://199.19.213.219:2380"]} {"level":"info","ts":"2026-07-27T10:44:52.646563Z","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-07-27T10:44:52.646745Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"7e142186203fa167","initial-advertise-peer-urls":["https://199.19.213.219:2380"],"listen-peer-urls":["https://199.19.213.219:2380"],"advertise-client-urls":["https://199.19.213.219:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.219:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-27T10:44:52.646768Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-27T10:44:52.64686Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.219:2380"} {"level":"info","ts":"2026-07-27T10:44:52.646874Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.219:2380"} {"level":"info","ts":"2026-07-27T10:44:53.125237Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 is starting a new election at term 1"} {"level":"info","ts":"2026-07-27T10:44:53.125327Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-27T10:44:53.125396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 received MsgPreVoteResp from 7e142186203fa167 at term 1"} {"level":"info","ts":"2026-07-27T10:44:53.125429Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 became candidate at term 2"} {"level":"info","ts":"2026-07-27T10:44:53.125463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 received MsgVoteResp from 7e142186203fa167 at term 2"} {"level":"info","ts":"2026-07-27T10:44:53.12549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e142186203fa167 became leader at term 2"} {"level":"info","ts":"2026-07-27T10:44:53.125509Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 7e142186203fa167 elected leader 7e142186203fa167 at term 2"} {"level":"info","ts":"2026-07-27T10:44:53.126573Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"7e142186203fa167","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.219:2379]}","request-path":"/0/members/7e142186203fa167/attributes","cluster-id":"e7586aea7e662ee6","publish-timeout":"7s"} {"level":"info","ts":"2026-07-27T10:44:53.126663Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-27T10:44:53.126751Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-27T10:44:53.126915Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-27T10:44:53.126828Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-27T10:44:53.126969Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-27T10:44:53.127823Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e7586aea7e662ee6","local-member-id":"7e142186203fa167","cluster-version":"3.5"} {"level":"info","ts":"2026-07-27T10:44:53.127954Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-27T10:44:53.127996Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-27T10:44:53.129444Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.219:2379"} {"level":"info","ts":"2026-07-27T10:44:53.13Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-27T10:45:13.053463Z","caller":"traceutil/trace.go:171","msg":"trace[1791559853] linearizableReadLoop","detail":"{readStateIndex:398; appliedIndex:397; }","duration":"191.95364ms","start":"2026-07-27T10:45:12.861483Z","end":"2026-07-27T10:45:13.053437Z","steps":["trace[1791559853] 'read index received' (duration: 191.834726ms)","trace[1791559853] 'applied index is now lower than readState.Index' (duration: 117.824µs)"],"step_count":2} {"level":"info","ts":"2026-07-27T10:45:13.053561Z","caller":"traceutil/trace.go:171","msg":"trace[908871659] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"231.785913ms","start":"2026-07-27T10:45:12.821741Z","end":"2026-07-27T10:45:13.053527Z","steps":["trace[908871659] 'process raft request' (duration: 231.528816ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:45:13.053674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.116154ms","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-07-27T10:45:13.053804Z","caller":"traceutil/trace.go:171","msg":"trace[630506614] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:382; }","duration":"192.336728ms","start":"2026-07-27T10:45:12.861449Z","end":"2026-07-27T10:45:13.053786Z","steps":["trace[630506614] 'agreement among raft nodes before linearized reading' (duration: 192.106553ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:45:35.813652Z","caller":"traceutil/trace.go:171","msg":"trace[1380502054] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"117.538997ms","start":"2026-07-27T10:45:35.696086Z","end":"2026-07-27T10:45:35.813625Z","steps":["trace[1380502054] 'process raft request' (duration: 116.594119ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:45:35.819513Z","caller":"traceutil/trace.go:171","msg":"trace[852767647] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"118.245612ms","start":"2026-07-27T10:45:35.701251Z","end":"2026-07-27T10:45:35.819497Z","steps":["trace[852767647] 'process raft request' (duration: 118.102489ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:45:35.819815Z","caller":"traceutil/trace.go:171","msg":"trace[1892488809] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"111.160339ms","start":"2026-07-27T10:45:35.708639Z","end":"2026-07-27T10:45:35.819799Z","steps":["trace[1892488809] 'process raft request' (duration: 110.800711ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:45:35.819964Z","caller":"traceutil/trace.go:171","msg":"trace[1102815466] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"102.725736ms","start":"2026-07-27T10:45:35.717228Z","end":"2026-07-27T10:45:35.819953Z","steps":["trace[1102815466] 'process raft request' (duration: 102.237615ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:45:35.819988Z","caller":"traceutil/trace.go:171","msg":"trace[177451530] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"102.577053ms","start":"2026-07-27T10:45:35.717392Z","end":"2026-07-27T10:45:35.819969Z","steps":["trace[177451530] 'process raft request' (duration: 102.097633ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:45:36.809461Z","caller":"traceutil/trace.go:171","msg":"trace[2106212418] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"141.823128ms","start":"2026-07-27T10:45:36.667607Z","end":"2026-07-27T10:45:36.80943Z","steps":["trace[2106212418] 'process raft request' (duration: 141.650165ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:45:42.087979Z","caller":"traceutil/trace.go:171","msg":"trace[826532706] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:632; }","duration":"103.684098ms","start":"2026-07-27T10:45:41.984261Z","end":"2026-07-27T10:45:42.087945Z","steps":["trace[826532706] 'read index received' (duration: 102.838193ms)","trace[826532706] 'applied index is now lower than readState.Index' (duration: 844.595µs)"],"step_count":2} {"level":"info","ts":"2026-07-27T10:45:42.088065Z","caller":"traceutil/trace.go:171","msg":"trace[1917606108] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"225.317078ms","start":"2026-07-27T10:45:41.862724Z","end":"2026-07-27T10:45:42.088042Z","steps":["trace[1917606108] 'process raft request' (duration: 224.629606ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:45:42.088206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.929175ms","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-07-27T10:45:42.088248Z","caller":"traceutil/trace.go:171","msg":"trace[277661476] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:607; }","duration":"104.047807ms","start":"2026-07-27T10:45:41.984188Z","end":"2026-07-27T10:45:42.088235Z","steps":["trace[277661476] 'agreement among raft nodes before linearized reading' (duration: 103.871433ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:45:42.744745Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11630440085898597665,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-27T10:45:42.786448Z","caller":"traceutil/trace.go:171","msg":"trace[726010750] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:634; }","duration":"542.247657ms","start":"2026-07-27T10:45:42.244162Z","end":"2026-07-27T10:45:42.78641Z","steps":["trace[726010750] 'read index received' (duration: 538.29106ms)","trace[726010750] 'applied index is now lower than readState.Index' (duration: 3.955567ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T10:45:42.786612Z","caller":"traceutil/trace.go:171","msg":"trace[708249854] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"631.678037ms","start":"2026-07-27T10:45:42.15488Z","end":"2026-07-27T10:45:42.786558Z","steps":["trace[708249854] 'process raft request' (duration: 627.517957ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:45:42.786722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.530942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-lxpsk\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-07-27T10:45:42.786796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.490098ms","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-07-27T10:45:42.786854Z","caller":"traceutil/trace.go:171","msg":"trace[289046212] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:609; }","duration":"439.596501ms","start":"2026-07-27T10:45:42.347245Z","end":"2026-07-27T10:45:42.786841Z","steps":["trace[289046212] 'agreement among raft nodes before linearized reading' (duration: 439.371535ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:45:42.786875Z","caller":"traceutil/trace.go:171","msg":"trace[860997736] range","detail":"{range_begin:/registry/pods/kube-system/cilium-lxpsk; range_end:; response_count:1; response_revision:609; }","duration":"542.684916ms","start":"2026-07-27T10:45:42.244102Z","end":"2026-07-27T10:45:42.786787Z","steps":["trace[860997736] 'agreement among raft nodes before linearized reading' (duration: 542.45711ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:45:42.786948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:45:42.244076Z","time spent":"542.845938ms","remote":"127.0.0.1:47678","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-lxpsk\" "} {"level":"warn","ts":"2026-07-27T10:45:42.78741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:45:42.1548Z","time spent":"631.922661ms","remote":"127.0.0.1:47976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-27T10:45:42.786899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:45:42.347225Z","time spent":"439.661712ms","remote":"127.0.0.1:47748","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-07-27T10:45:44.529465Z","caller":"traceutil/trace.go:171","msg":"trace[1429156284] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"132.372257ms","start":"2026-07-27T10:45:44.397067Z","end":"2026-07-27T10:45:44.529439Z","steps":["trace[1429156284] 'process raft request' (duration: 63.696266ms)","trace[1429156284] 'compare' (duration: 68.575309ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T10:45:57.76442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.053023ms","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-07-27T10:45:57.76446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.907587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-dlv7l\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-07-27T10:45:57.764552Z","caller":"traceutil/trace.go:171","msg":"trace[415021584] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:769; }","duration":"384.252357ms","start":"2026-07-27T10:45:57.380251Z","end":"2026-07-27T10:45:57.764503Z","steps":["trace[415021584] 'range keys from in-memory index tree' (duration: 383.613125ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:45:57.764606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:45:57.380226Z","time spent":"384.369159ms","remote":"127.0.0.1:47748","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-07-27T10:45:57.764636Z","caller":"traceutil/trace.go:171","msg":"trace[1303927828] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-dlv7l; range_end:; response_count:1; response_revision:769; }","duration":"403.196801ms","start":"2026-07-27T10:45:57.361399Z","end":"2026-07-27T10:45:57.764596Z","steps":["trace[1303927828] 'range keys from in-memory index tree' (duration: 402.622052ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:45:57.764486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.605795ms","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-07-27T10:45:57.764717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:45:57.361372Z","time spent":"403.325384ms","remote":"127.0.0.1:47678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-dlv7l\" "} {"level":"info","ts":"2026-07-27T10:45:57.764731Z","caller":"traceutil/trace.go:171","msg":"trace[747255812] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:769; }","duration":"387.934229ms","start":"2026-07-27T10:45:57.37677Z","end":"2026-07-27T10:45:57.764705Z","steps":["trace[747255812] 'range keys from in-memory index tree' (duration: 387.31308ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:45:57.764895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:45:57.376741Z","time spent":"388.046472ms","remote":"127.0.0.1:47748","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":"info","ts":"2026-07-27T10:46:28.54183Z","caller":"traceutil/trace.go:171","msg":"trace[930208124] transaction","detail":"{read_only:false; response_revision:1173; number_of_response:1; }","duration":"170.739617ms","start":"2026-07-27T10:46:28.371056Z","end":"2026-07-27T10:46:28.541796Z","steps":["trace[930208124] 'process raft request' (duration: 170.570414ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:47:14.567599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.836118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-27T10:47:14.567691Z","caller":"traceutil/trace.go:171","msg":"trace[1765180360] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1845; }","duration":"178.97113ms","start":"2026-07-27T10:47:14.388701Z","end":"2026-07-27T10:47:14.567672Z","steps":["trace[1765180360] 'range keys from in-memory index tree' (duration: 178.731217ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:47:14.933974Z","caller":"traceutil/trace.go:171","msg":"trace[1039935425] linearizableReadLoop","detail":"{readStateIndex:1921; appliedIndex:1920; }","duration":"189.890529ms","start":"2026-07-27T10:47:14.744056Z","end":"2026-07-27T10:47:14.933946Z","steps":["trace[1039935425] 'read index received' (duration: 189.731917ms)","trace[1039935425] 'applied index is now lower than readState.Index' (duration: 157.542µs)"],"step_count":2} {"level":"info","ts":"2026-07-27T10:47:14.934029Z","caller":"traceutil/trace.go:171","msg":"trace[1985023415] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"209.751861ms","start":"2026-07-27T10:47:14.724239Z","end":"2026-07-27T10:47:14.93399Z","steps":["trace[1985023415] 'process raft request' (duration: 209.556858ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:47:14.934171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.095031ms","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-07-27T10:47:14.934446Z","caller":"traceutil/trace.go:171","msg":"trace[1947141081] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1846; }","duration":"190.389654ms","start":"2026-07-27T10:47:14.744007Z","end":"2026-07-27T10:47:14.934397Z","steps":["trace[1947141081] 'agreement among raft nodes before linearized reading' (duration: 190.04077ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:47:15.267564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.920846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-27T10:47:15.267648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.330437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2d01899a-1d42-4e13-8f9b-21d23c6dbc39\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-07-27T10:47:15.267711Z","caller":"traceutil/trace.go:171","msg":"trace[2088750233] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1848; }","duration":"114.127069ms","start":"2026-07-27T10:47:15.153564Z","end":"2026-07-27T10:47:15.267692Z","steps":["trace[2088750233] 'range keys from in-memory index tree' (duration: 113.852105ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:47:15.267781Z","caller":"traceutil/trace.go:171","msg":"trace[1357144999] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2d01899a-1d42-4e13-8f9b-21d23c6dbc39; range_end:; response_count:1; response_revision:1848; }","duration":"105.517818ms","start":"2026-07-27T10:47:15.162234Z","end":"2026-07-27T10:47:15.267752Z","steps":["trace[1357144999] 'range keys from in-memory index tree' (duration: 105.077214ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:47:29.321858Z","caller":"traceutil/trace.go:171","msg":"trace[772929491] linearizableReadLoop","detail":"{readStateIndex:2041; appliedIndex:2040; }","duration":"200.11462ms","start":"2026-07-27T10:47:29.121726Z","end":"2026-07-27T10:47:29.321841Z","steps":["trace[772929491] 'read index received' (duration: 199.966979ms)","trace[772929491] 'applied index is now lower than readState.Index' (duration: 146.951µs)"],"step_count":2} {"level":"info","ts":"2026-07-27T10:47:29.322096Z","caller":"traceutil/trace.go:171","msg":"trace[1947994770] transaction","detail":"{read_only:false; response_revision:1962; number_of_response:1; }","duration":"306.819194ms","start":"2026-07-27T10:47:29.015266Z","end":"2026-07-27T10:47:29.322085Z","steps":["trace[1947994770] 'process raft request' (duration: 306.47725ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:47:29.322328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:47:29.015252Z","time spent":"306.875274ms","remote":"127.0.0.1:47748","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-07-27T10:47:29.322582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.861949ms","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-07-27T10:47:29.322628Z","caller":"traceutil/trace.go:171","msg":"trace[701072368] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1962; }","duration":"200.931229ms","start":"2026-07-27T10:47:29.12168Z","end":"2026-07-27T10:47:29.322611Z","steps":["trace[701072368] 'agreement among raft nodes before linearized reading' (duration: 200.833318ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:47:29.322758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.037971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-27T10:47:29.322788Z","caller":"traceutil/trace.go:171","msg":"trace[295529900] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1962; }","duration":"167.095211ms","start":"2026-07-27T10:47:29.155685Z","end":"2026-07-27T10:47:29.32278Z","steps":["trace[295529900] 'agreement among raft nodes before linearized reading' (duration: 167.055881ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:47:47.550145Z","caller":"traceutil/trace.go:171","msg":"trace[1084431214] transaction","detail":"{read_only:false; response_revision:2074; number_of_response:1; }","duration":"129.49333ms","start":"2026-07-27T10:47:47.420618Z","end":"2026-07-27T10:47:47.550111Z","steps":["trace[1084431214] 'process raft request' (duration: 41.133191ms)","trace[1084431214] 'compare' (duration: 88.117586ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T10:47:47.814211Z","caller":"traceutil/trace.go:171","msg":"trace[1983342011] transaction","detail":"{read_only:false; response_revision:2079; number_of_response:1; }","duration":"134.979621ms","start":"2026-07-27T10:47:47.679202Z","end":"2026-07-27T10:47:47.814182Z","steps":["trace[1983342011] 'process raft request' (duration: 100.155726ms)","trace[1983342011] 'compare' (duration: 34.702973ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T10:47:48.207149Z","caller":"traceutil/trace.go:171","msg":"trace[1065338845] transaction","detail":"{read_only:false; response_revision:2080; number_of_response:1; }","duration":"178.881207ms","start":"2026-07-27T10:47:48.028221Z","end":"2026-07-27T10:47:48.207102Z","steps":["trace[1065338845] 'process raft request' (duration: 178.599254ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:47:48.7947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.516592ms","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-07-27T10:47:48.794798Z","caller":"traceutil/trace.go:171","msg":"trace[1998821665] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2081; }","duration":"273.656753ms","start":"2026-07-27T10:47:48.52112Z","end":"2026-07-27T10:47:48.794777Z","steps":["trace[1998821665] 'range keys from in-memory index tree' (duration: 273.32352ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:47:48.809481Z","caller":"traceutil/trace.go:171","msg":"trace[1464005023] transaction","detail":"{read_only:false; response_revision:2082; number_of_response:1; }","duration":"100.495987ms","start":"2026-07-27T10:47:48.708961Z","end":"2026-07-27T10:47:48.809457Z","steps":["trace[1464005023] 'process raft request' (duration: 100.349195ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:47:49.133457Z","caller":"traceutil/trace.go:171","msg":"trace[1138469223] linearizableReadLoop","detail":"{readStateIndex:2166; appliedIndex:2165; }","duration":"297.349634ms","start":"2026-07-27T10:47:48.836079Z","end":"2026-07-27T10:47:49.133428Z","steps":["trace[1138469223] 'read index received' (duration: 214.465358ms)","trace[1138469223] 'applied index is now lower than readState.Index' (duration: 82.882926ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T10:47:49.133532Z","caller":"traceutil/trace.go:171","msg":"trace[1052097005] transaction","detail":"{read_only:false; response_revision:2083; number_of_response:1; }","duration":"334.427802ms","start":"2026-07-27T10:47:48.79908Z","end":"2026-07-27T10:47:49.133507Z","steps":["trace[1052097005] 'process raft request' (duration: 251.539335ms)","trace[1052097005] 'compare' (duration: 82.592314ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T10:47:49.133648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:47:48.799059Z","time spent":"334.515252ms","remote":"127.0.0.1:47748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-27T10:47:49.133914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.5411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-27T10:47:49.134108Z","caller":"traceutil/trace.go:171","msg":"trace[311947625] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:2083; }","duration":"178.782942ms","start":"2026-07-27T10:47:48.955308Z","end":"2026-07-27T10:47:49.134091Z","steps":["trace[311947625] 'agreement among raft nodes before linearized reading' (duration: 178.53117ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:47:49.134921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.821519ms","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-07-27T10:47:49.135268Z","caller":"traceutil/trace.go:171","msg":"trace[1129519031] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2083; }","duration":"299.210433ms","start":"2026-07-27T10:47:48.836031Z","end":"2026-07-27T10:47:49.135241Z","steps":["trace[1129519031] 'agreement among raft nodes before linearized reading' (duration: 297.527145ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:48:44.553897Z","caller":"traceutil/trace.go:171","msg":"trace[128842840] transaction","detail":"{read_only:false; response_revision:2491; number_of_response:1; }","duration":"173.046347ms","start":"2026-07-27T10:48:44.380829Z","end":"2026-07-27T10:48:44.553876Z","steps":["trace[128842840] 'process raft request' (duration: 172.930086ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:49:16.52985Z","caller":"traceutil/trace.go:171","msg":"trace[339780665] linearizableReadLoop","detail":"{readStateIndex:2770; appliedIndex:2769; }","duration":"106.273449ms","start":"2026-07-27T10:49:16.42355Z","end":"2026-07-27T10:49:16.529824Z","steps":["trace[339780665] 'read index received' (duration: 106.079644ms)","trace[339780665] 'applied index is now lower than readState.Index' (duration: 192.495µs)"],"step_count":2} {"level":"warn","ts":"2026-07-27T10:49:16.53013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.565637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-07-27T10:49:16.530235Z","caller":"traceutil/trace.go:171","msg":"trace[1346330188] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2666; }","duration":"106.715422ms","start":"2026-07-27T10:49:16.423503Z","end":"2026-07-27T10:49:16.530219Z","steps":["trace[1346330188] 'agreement among raft nodes before linearized reading' (duration: 106.369302ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:49:16.915039Z","caller":"traceutil/trace.go:171","msg":"trace[166888567] linearizableReadLoop","detail":"{readStateIndex:2772; appliedIndex:2771; }","duration":"106.729761ms","start":"2026-07-27T10:49:16.808292Z","end":"2026-07-27T10:49:16.915022Z","steps":["trace[166888567] 'read index received' (duration: 106.605148ms)","trace[166888567] 'applied index is now lower than readState.Index' (duration: 123.773µs)"],"step_count":2} {"level":"warn","ts":"2026-07-27T10:49:16.915206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.898175ms","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-07-27T10:49:16.915225Z","caller":"traceutil/trace.go:171","msg":"trace[517490988] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2668; }","duration":"106.977698ms","start":"2026-07-27T10:49:16.808239Z","end":"2026-07-27T10:49:16.915217Z","steps":["trace[517490988] 'agreement among raft nodes before linearized reading' (duration: 106.854414ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:49:16.915436Z","caller":"traceutil/trace.go:171","msg":"trace[178466841] transaction","detail":"{read_only:false; response_revision:2668; number_of_response:1; }","duration":"244.249122ms","start":"2026-07-27T10:49:16.671174Z","end":"2026-07-27T10:49:16.915423Z","steps":["trace[178466841] 'process raft request' (duration: 243.709368ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:51:20.183243Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11630440085898603992,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-27T10:51:20.481442Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.093865506s","expected-duration":"1s"} {"level":"info","ts":"2026-07-27T10:51:20.482561Z","caller":"traceutil/trace.go:171","msg":"trace[885227049] linearizableReadLoop","detail":"{readStateIndex:3525; appliedIndex:3524; }","duration":"799.405845ms","start":"2026-07-27T10:51:19.683124Z","end":"2026-07-27T10:51:20.48253Z","steps":["trace[885227049] 'read index received' (duration: 798.785235ms)","trace[885227049] 'applied index is now lower than readState.Index' (duration: 619.49µs)"],"step_count":2} {"level":"info","ts":"2026-07-27T10:51:20.482917Z","caller":"traceutil/trace.go:171","msg":"trace[242864500] transaction","detail":"{read_only:false; response_revision:3392; number_of_response:1; }","duration":"1.095454592s","start":"2026-07-27T10:51:19.387453Z","end":"2026-07-27T10:51:20.482907Z","steps":["trace[242864500] 'process raft request' (duration: 1.094258221s)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:51:20.483073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:51:19.387421Z","time spent":"1.095524393s","remote":"127.0.0.1:47748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-27T10:51:20.48339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"800.157778ms","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-07-27T10:51:20.483469Z","caller":"traceutil/trace.go:171","msg":"trace[1171929648] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3392; }","duration":"800.329731ms","start":"2026-07-27T10:51:19.683116Z","end":"2026-07-27T10:51:20.483446Z","steps":["trace[1171929648] 'agreement among raft nodes before linearized reading' (duration: 799.800542ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:51:20.483662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:51:19.683027Z","time spent":"800.620976ms","remote":"127.0.0.1:47748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-27T10:51:20.496769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.654878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-07-27T10:51:20.496879Z","caller":"traceutil/trace.go:171","msg":"trace[752246716] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:3394; }","duration":"497.854293ms","start":"2026-07-27T10:51:19.999001Z","end":"2026-07-27T10:51:20.496856Z","steps":["trace[752246716] 'agreement among raft nodes before linearized reading' (duration: 497.561057ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:51:20.496942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:51:19.99898Z","time spent":"497.953945ms","remote":"127.0.0.1:47748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":553,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"warn","ts":"2026-07-27T10:51:20.497094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.313938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-27T10:51:20.497121Z","caller":"traceutil/trace.go:171","msg":"trace[994225694] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3394; }","duration":"340.3896ms","start":"2026-07-27T10:51:20.156724Z","end":"2026-07-27T10:51:20.497114Z","steps":["trace[994225694] 'agreement among raft nodes before linearized reading' (duration: 340.342539ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:51:20.497142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:51:20.156696Z","time spent":"340.43902ms","remote":"127.0.0.1:47482","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-07-27T10:51:20.497168Z","caller":"traceutil/trace.go:171","msg":"trace[1543486231] transaction","detail":"{read_only:false; response_revision:3393; number_of_response:1; }","duration":"140.029806ms","start":"2026-07-27T10:51:20.357105Z","end":"2026-07-27T10:51:20.497135Z","steps":["trace[1543486231] 'process raft request' (duration: 139.176941ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:51:20.497374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.45408ms","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-07-27T10:51:20.497401Z","caller":"traceutil/trace.go:171","msg":"trace[2103185701] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3394; }","duration":"357.528661ms","start":"2026-07-27T10:51:20.139866Z","end":"2026-07-27T10:51:20.497394Z","steps":["trace[2103185701] 'agreement among raft nodes before linearized reading' (duration: 357.45885ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:51:20.497424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:51:20.139836Z","time spent":"357.583203ms","remote":"127.0.0.1:47748","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":"info","ts":"2026-07-27T10:51:28.704899Z","caller":"traceutil/trace.go:171","msg":"trace[1443950400] transaction","detail":"{read_only:false; response_revision:3445; number_of_response:1; }","duration":"190.605344ms","start":"2026-07-27T10:51:28.514267Z","end":"2026-07-27T10:51:28.704872Z","steps":["trace[1443950400] 'process raft request' (duration: 190.394761ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:51:28.732798Z","caller":"traceutil/trace.go:171","msg":"trace[1346489576] transaction","detail":"{read_only:false; response_revision:3446; number_of_response:1; }","duration":"208.397192ms","start":"2026-07-27T10:51:28.524368Z","end":"2026-07-27T10:51:28.732766Z","steps":["trace[1346489576] 'process raft request' (duration: 208.179159ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:51:28.733252Z","caller":"traceutil/trace.go:171","msg":"trace[432275544] transaction","detail":"{read_only:false; response_revision:3447; number_of_response:1; }","duration":"205.536714ms","start":"2026-07-27T10:51:28.527686Z","end":"2026-07-27T10:51:28.733222Z","steps":["trace[432275544] 'process raft request' (duration: 205.027796ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:51:28.733691Z","caller":"traceutil/trace.go:171","msg":"trace[2143973517] linearizableReadLoop","detail":"{readStateIndex:3582; appliedIndex:3579; }","duration":"201.68628ms","start":"2026-07-27T10:51:28.53198Z","end":"2026-07-27T10:51:28.733666Z","steps":["trace[2143973517] 'read index received' (duration: 172.661635ms)","trace[2143973517] 'applied index is now lower than readState.Index' (duration: 29.023445ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T10:51:28.733979Z","caller":"traceutil/trace.go:171","msg":"trace[1462164103] transaction","detail":"{read_only:false; response_revision:3448; number_of_response:1; }","duration":"135.384192ms","start":"2026-07-27T10:51:28.598563Z","end":"2026-07-27T10:51:28.733947Z","steps":["trace[1462164103] 'process raft request' (duration: 134.558628ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:51:28.73402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.176949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-27T10:51:28.734198Z","caller":"traceutil/trace.go:171","msg":"trace[612117440] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3448; }","duration":"199.404853ms","start":"2026-07-27T10:51:28.534772Z","end":"2026-07-27T10:51:28.734177Z","steps":["trace[612117440] 'agreement among raft nodes before linearized reading' (duration: 199.129028ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:51:28.734033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.036387ms","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-07-27T10:51:28.734736Z","caller":"traceutil/trace.go:171","msg":"trace[1824169807] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3448; }","duration":"202.783038ms","start":"2026-07-27T10:51:28.53193Z","end":"2026-07-27T10:51:28.734713Z","steps":["trace[1824169807] 'agreement among raft nodes before linearized reading' (duration: 201.935845ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:51:29.019174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.16979ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-27T10:51:29.019435Z","caller":"traceutil/trace.go:171","msg":"trace[273140567] linearizableReadLoop","detail":"{readStateIndex:3585; appliedIndex:3583; }","duration":"268.995554ms","start":"2026-07-27T10:51:28.750422Z","end":"2026-07-27T10:51:29.019417Z","steps":["trace[273140567] 'read index received' (duration: 15.330546ms)","trace[273140567] 'applied index is now lower than readState.Index' (duration: 253.663478ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T10:51:29.019588Z","caller":"traceutil/trace.go:171","msg":"trace[1980505459] transaction","detail":"{read_only:false; response_revision:3449; number_of_response:1; }","duration":"280.049408ms","start":"2026-07-27T10:51:28.739527Z","end":"2026-07-27T10:51:29.019577Z","steps":["trace[1980505459] 'process raft request' (duration: 26.215147ms)","trace[1980505459] 'compare' (duration: 253.046978ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T10:51:29.01986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.221566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-07-27T10:51:29.019928Z","caller":"traceutil/trace.go:171","msg":"trace[1473181916] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3450; }","duration":"266.314879ms","start":"2026-07-27T10:51:28.753597Z","end":"2026-07-27T10:51:29.019912Z","steps":["trace[1473181916] 'agreement among raft nodes before linearized reading' (duration: 266.135886ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:51:29.019906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.472512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-07-27T10:51:29.020262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.666048ms","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-07-27T10:51:29.020302Z","caller":"traceutil/trace.go:171","msg":"trace[1226894718] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3450; }","duration":"207.76731ms","start":"2026-07-27T10:51:28.812525Z","end":"2026-07-27T10:51:29.020292Z","steps":["trace[1226894718] 'agreement among raft nodes before linearized reading' (duration: 207.566647ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:51:29.020428Z","caller":"traceutil/trace.go:171","msg":"trace[1025359376] transaction","detail":"{read_only:false; response_revision:3450; number_of_response:1; }","duration":"280.851681ms","start":"2026-07-27T10:51:28.739564Z","end":"2026-07-27T10:51:29.020416Z","steps":["trace[1025359376] 'process raft request' (duration: 279.720182ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:51:29.021283Z","caller":"traceutil/trace.go:171","msg":"trace[971676389] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3450; }","duration":"269.916959ms","start":"2026-07-27T10:51:28.750362Z","end":"2026-07-27T10:51:29.020279Z","steps":["trace[971676389] 'agreement among raft nodes before linearized reading' (duration: 269.335779ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:51:29.250955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.584394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-27T10:51:29.251068Z","caller":"traceutil/trace.go:171","msg":"trace[2028765390] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:3453; }","duration":"119.744696ms","start":"2026-07-27T10:51:29.131297Z","end":"2026-07-27T10:51:29.251042Z","steps":["trace[2028765390] 'range keys from in-memory index tree' (duration: 119.481681ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:51:31.180818Z","caller":"traceutil/trace.go:171","msg":"trace[190893388] linearizableReadLoop","detail":"{readStateIndex:3594; appliedIndex:3592; }","duration":"105.202915ms","start":"2026-07-27T10:51:31.075588Z","end":"2026-07-27T10:51:31.180791Z","steps":["trace[190893388] 'read index received' (duration: 5.756646ms)","trace[190893388] 'applied index is now lower than readState.Index' (duration: 99.445129ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T10:51:31.180871Z","caller":"traceutil/trace.go:171","msg":"trace[84487619] transaction","detail":"{read_only:false; response_revision:3459; number_of_response:1; }","duration":"149.068652ms","start":"2026-07-27T10:51:31.031758Z","end":"2026-07-27T10:51:31.180827Z","steps":["trace[84487619] 'process raft request' (duration: 88.274574ms)","trace[84487619] 'compare' (duration: 60.629395ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T10:51:31.18114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.53631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-07-27T10:51:31.181193Z","caller":"traceutil/trace.go:171","msg":"trace[1615414008] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3459; }","duration":"105.681272ms","start":"2026-07-27T10:51:31.075495Z","end":"2026-07-27T10:51:31.181177Z","steps":["trace[1615414008] 'agreement among raft nodes before linearized reading' (duration: 105.466519ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:51:31.353497Z","caller":"traceutil/trace.go:171","msg":"trace[2112922873] transaction","detail":"{read_only:false; response_revision:3461; number_of_response:1; }","duration":"166.32849ms","start":"2026-07-27T10:51:31.187133Z","end":"2026-07-27T10:51:31.353462Z","steps":["trace[2112922873] 'process raft request' (duration: 139.634436ms)","trace[2112922873] 'compare' (duration: 26.51061ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T10:51:31.353565Z","caller":"traceutil/trace.go:171","msg":"trace[1119465917] transaction","detail":"{read_only:false; response_revision:3462; number_of_response:1; }","duration":"165.974834ms","start":"2026-07-27T10:51:31.187567Z","end":"2026-07-27T10:51:31.353541Z","steps":["trace[1119465917] 'process raft request' (duration: 165.851062ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:51:33.095225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.512781561s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-alertmanager-client-secret\" ","response":"range_response_count:1 size:1229"} {"level":"info","ts":"2026-07-27T10:51:33.095519Z","caller":"traceutil/trace.go:171","msg":"trace[2061629432] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-alertmanager-client-secret; range_end:; response_count:1; response_revision:3462; }","duration":"1.513123726s","start":"2026-07-27T10:51:31.582367Z","end":"2026-07-27T10:51:33.09549Z","steps":["trace[2061629432] 'range keys from in-memory index tree' (duration: 1.512509725s)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:51:33.095619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:51:31.582343Z","time spent":"1.513262319s","remote":"127.0.0.1:54254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":1,"response size":1252,"request content":"key:\"/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-alertmanager-client-secret\" "} {"level":"warn","ts":"2026-07-27T10:51:33.162394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.387867312s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-27T10:51:33.162722Z","caller":"traceutil/trace.go:171","msg":"trace[617127952] linearizableReadLoop","detail":"{readStateIndex:3598; appliedIndex:3597; }","duration":"1.360602441s","start":"2026-07-27T10:51:31.80206Z","end":"2026-07-27T10:51:33.162663Z","steps":["trace[617127952] 'read index received' (duration: 63.091µs)","trace[617127952] 'applied index is now lower than readState.Index' (duration: 1.36053363s)"],"step_count":2} {"level":"info","ts":"2026-07-27T10:51:33.162953Z","caller":"traceutil/trace.go:171","msg":"trace[208203020] transaction","detail":"{read_only:false; response_revision:3467; number_of_response:1; }","duration":"355.493198ms","start":"2026-07-27T10:51:32.807429Z","end":"2026-07-27T10:51:33.162922Z","steps":["trace[208203020] 'process raft request' (duration: 355.448667ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:51:33.163099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.360995157s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-27T10:51:33.163139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:51:32.80741Z","time spent":"355.6181ms","remote":"127.0.0.1:47748","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-07-27T10:51:33.163278Z","caller":"traceutil/trace.go:171","msg":"trace[56908085] transaction","detail":"{read_only:false; response_revision:3464; number_of_response:1; }","duration":"407.316455ms","start":"2026-07-27T10:51:32.755915Z","end":"2026-07-27T10:51:33.163232Z","steps":["trace[56908085] 'process raft request' (duration: 406.824707ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:51:33.163507Z","caller":"traceutil/trace.go:171","msg":"trace[1099954960] transaction","detail":"{read_only:false; response_revision:3465; number_of_response:1; }","duration":"366.510969ms","start":"2026-07-27T10:51:32.796976Z","end":"2026-07-27T10:51:33.163487Z","steps":["trace[1099954960] 'process raft request' (duration: 365.826258ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:51:33.163685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:51:32.755888Z","time spent":"407.529679ms","remote":"127.0.0.1:47748","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-07-27T10:51:33.163365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.182655968s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-grafana-client-secret\" ","response":"range_response_count:1 size:1219"} {"level":"info","ts":"2026-07-27T10:51:33.166235Z","caller":"traceutil/trace.go:171","msg":"trace[223054747] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-grafana-client-secret; range_end:; response_count:1; response_revision:3467; }","duration":"1.185554407s","start":"2026-07-27T10:51:31.980657Z","end":"2026-07-27T10:51:33.166211Z","steps":["trace[223054747] 'agreement among raft nodes before linearized reading' (duration: 1.182552008s)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:51:33.166374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:51:31.980635Z","time spent":"1.185713309s","remote":"127.0.0.1:54254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":1242,"request content":"key:\"/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-grafana-client-secret\" "} {"level":"warn","ts":"2026-07-27T10:51:33.163769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.273202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-27T10:51:33.1665Z","caller":"traceutil/trace.go:171","msg":"trace[1591932571] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:3467; }","duration":"283.104589ms","start":"2026-07-27T10:51:32.883373Z","end":"2026-07-27T10:51:33.166477Z","steps":["trace[1591932571] 'agreement among raft nodes before linearized reading' (duration: 280.204661ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:51:33.164091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.008156009s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-grafana-client-secret\" ","response":"range_response_count:1 size:1219"} {"level":"info","ts":"2026-07-27T10:51:33.166612Z","caller":"traceutil/trace.go:171","msg":"trace[1680874840] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-grafana-client-secret; range_end:; response_count:1; response_revision:3467; }","duration":"1.010928326s","start":"2026-07-27T10:51:32.155662Z","end":"2026-07-27T10:51:33.16659Z","steps":["trace[1680874840] 'agreement among raft nodes before linearized reading' (duration: 1.008031527s)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:51:33.163164Z","caller":"traceutil/trace.go:171","msg":"trace[1598849817] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:3467; }","duration":"1.36115088s","start":"2026-07-27T10:51:31.80199Z","end":"2026-07-27T10:51:33.163141Z","steps":["trace[1598849817] 'agreement among raft nodes before linearized reading' (duration: 1.360919686s)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:51:33.166764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:51:31.801951Z","time spent":"1.36479564s","remote":"127.0.0.1:47958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":6,"response size":30,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "} {"level":"info","ts":"2026-07-27T10:51:33.164141Z","caller":"traceutil/trace.go:171","msg":"trace[1616458811] transaction","detail":"{read_only:false; response_revision:3463; number_of_response:1; }","duration":"442.784583ms","start":"2026-07-27T10:51:32.721109Z","end":"2026-07-27T10:51:33.163894Z","steps":["trace[1616458811] 'process raft request' (duration: 441.443881ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:51:33.167128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:51:32.721074Z","time spent":"445.933375ms","remote":"127.0.0.1:47748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-27T10:51:33.167157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:51:32.155634Z","time spent":"1.011055119s","remote":"127.0.0.1:54254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":1242,"request content":"key:\"/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-grafana-client-secret\" "} {"level":"warn","ts":"2026-07-27T10:51:33.164352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:51:32.796937Z","time spent":"366.618752ms","remote":"127.0.0.1:47748","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-07-27T10:51:33.16417Z","caller":"traceutil/trace.go:171","msg":"trace[275833786] transaction","detail":"{read_only:false; response_revision:3466; number_of_response:1; }","duration":"356.854781ms","start":"2026-07-27T10:51:32.807298Z","end":"2026-07-27T10:51:33.164152Z","steps":["trace[275833786] 'process raft request' (duration: 355.541549ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:51:33.167419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:51:32.807278Z","time spent":"360.055863ms","remote":"127.0.0.1:47748","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-07-27T10:51:33.380289Z","caller":"traceutil/trace.go:171","msg":"trace[1880177927] linearizableReadLoop","detail":"{readStateIndex:3605; appliedIndex:3604; }","duration":"171.925469ms","start":"2026-07-27T10:51:33.208328Z","end":"2026-07-27T10:51:33.380253Z","steps":["trace[1880177927] 'read index received' (duration: 86.974086ms)","trace[1880177927] 'applied index is now lower than readState.Index' (duration: 84.949663ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T10:51:33.380508Z","caller":"traceutil/trace.go:171","msg":"trace[878770640] transaction","detail":"{read_only:false; response_revision:3469; number_of_response:1; }","duration":"183.382098ms","start":"2026-07-27T10:51:33.19709Z","end":"2026-07-27T10:51:33.380472Z","steps":["trace[878770640] 'process raft request' (duration: 98.303374ms)","trace[878770640] 'compare' (duration: 84.710968ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T10:51:33.381491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.128309ms","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-07-27T10:51:33.381641Z","caller":"traceutil/trace.go:171","msg":"trace[17203452] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3469; }","duration":"173.316522ms","start":"2026-07-27T10:51:33.208303Z","end":"2026-07-27T10:51:33.381619Z","steps":["trace[17203452] 'agreement among raft nodes before linearized reading' (duration: 172.824734ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:51:33.648133Z","caller":"traceutil/trace.go:171","msg":"trace[1620984076] transaction","detail":"{read_only:false; response_revision:3472; number_of_response:1; }","duration":"261.63481ms","start":"2026-07-27T10:51:33.386463Z","end":"2026-07-27T10:51:33.648098Z","steps":["trace[1620984076] 'process raft request' (duration: 261.522298ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:51:33.648291Z","caller":"traceutil/trace.go:171","msg":"trace[1505514516] transaction","detail":"{read_only:false; response_revision:3471; number_of_response:1; }","duration":"262.592847ms","start":"2026-07-27T10:51:33.385644Z","end":"2026-07-27T10:51:33.648237Z","steps":["trace[1505514516] 'process raft request' (duration: 225.356002ms)","trace[1505514516] 'compare' (duration: 36.808997ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T10:51:34.107281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.468137ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-27T10:51:34.107416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.022172ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-27T10:51:34.107457Z","caller":"traceutil/trace.go:171","msg":"trace[255822256] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:3473; }","duration":"131.69357ms","start":"2026-07-27T10:51:33.975738Z","end":"2026-07-27T10:51:34.107432Z","steps":["trace[255822256] 'range keys from in-memory index tree' (duration: 131.438176ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:51:34.107565Z","caller":"traceutil/trace.go:171","msg":"trace[413133670] transaction","detail":"{read_only:false; response_revision:3474; number_of_response:1; }","duration":"182.675483ms","start":"2026-07-27T10:51:33.924865Z","end":"2026-07-27T10:51:34.10754Z","steps":["trace[413133670] 'process raft request' (duration: 43.441397ms)","trace[413133670] 'compare' (duration: 138.813828ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T10:52:01.481387Z","caller":"traceutil/trace.go:171","msg":"trace[2000953943] transaction","detail":"{read_only:false; response_revision:3622; number_of_response:1; }","duration":"152.609673ms","start":"2026-07-27T10:52:01.32862Z","end":"2026-07-27T10:52:01.48123Z","steps":["trace[2000953943] 'process raft request' (duration: 150.782995ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:52:01.796195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.939127ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-27T10:52:01.796473Z","caller":"traceutil/trace.go:171","msg":"trace[1514063132] transaction","detail":"{read_only:false; response_revision:3624; number_of_response:1; }","duration":"224.557372ms","start":"2026-07-27T10:52:01.57187Z","end":"2026-07-27T10:52:01.796427Z","steps":["trace[1514063132] 'process raft request' (duration: 26.265499ms)","trace[1514063132] 'compare' (duration: 197.816335ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T10:52:01.797076Z","caller":"traceutil/trace.go:171","msg":"trace[26359255] linearizableReadLoop","detail":"{readStateIndex:3765; appliedIndex:3764; }","duration":"135.596748ms","start":"2026-07-27T10:52:01.661209Z","end":"2026-07-27T10:52:01.796805Z","steps":["trace[26359255] 'read index received' (duration: 35.931µs)","trace[26359255] 'applied index is now lower than readState.Index' (duration: 135.559567ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T10:52:01.8587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.46052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-prometheus-cookie-secret\" ","response":"range_response_count:1 size:1225"} {"level":"info","ts":"2026-07-27T10:52:01.858795Z","caller":"traceutil/trace.go:171","msg":"trace[1919377475] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-prometheus-cookie-secret; range_end:; response_count:1; response_revision:3624; }","duration":"197.616022ms","start":"2026-07-27T10:52:01.661154Z","end":"2026-07-27T10:52:01.85877Z","steps":["trace[1919377475] 'agreement among raft nodes before linearized reading' (duration: 135.965234ms)","trace[1919377475] 'range keys from in-memory index tree' (duration: 61.361194ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T10:52:03.436459Z","caller":"traceutil/trace.go:171","msg":"trace[275978342] transaction","detail":"{read_only:false; response_revision:3631; number_of_response:1; }","duration":"106.448659ms","start":"2026-07-27T10:52:03.329965Z","end":"2026-07-27T10:52:03.436414Z","steps":["trace[275978342] 'process raft request' (duration: 45.833611ms)","trace[275978342] 'compare' (duration: 60.292943ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T10:52:03.436461Z","caller":"traceutil/trace.go:171","msg":"trace[2123905322] transaction","detail":"{read_only:false; response_revision:3633; number_of_response:1; }","duration":"106.419408ms","start":"2026-07-27T10:52:03.330007Z","end":"2026-07-27T10:52:03.436426Z","steps":["trace[2123905322] 'process raft request' (duration: 106.312746ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:52:03.436483Z","caller":"traceutil/trace.go:171","msg":"trace[1054237562] transaction","detail":"{read_only:false; response_revision:3632; number_of_response:1; }","duration":"106.449438ms","start":"2026-07-27T10:52:03.330007Z","end":"2026-07-27T10:52:03.436456Z","steps":["trace[1054237562] 'process raft request' (duration: 106.230535ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:53:13.244802Z","caller":"traceutil/trace.go:171","msg":"trace[1027740411] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4489; }","duration":"134.242818ms","start":"2026-07-27T10:53:13.110528Z","end":"2026-07-27T10:53:13.244771Z","steps":["trace[1027740411] 'process raft request' (duration: 134.012445ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:53:15.313355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.150306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-07-27T10:53:15.313426Z","caller":"traceutil/trace.go:171","msg":"trace[1258384822] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4575; }","duration":"106.256398ms","start":"2026-07-27T10:53:15.207152Z","end":"2026-07-27T10:53:15.313408Z","steps":["trace[1258384822] 'range keys from in-memory index tree' (duration: 105.976894ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:53:15.727051Z","caller":"traceutil/trace.go:171","msg":"trace[893867474] transaction","detail":"{read_only:false; response_revision:4582; number_of_response:1; }","duration":"104.849008ms","start":"2026-07-27T10:53:15.622177Z","end":"2026-07-27T10:53:15.727026Z","steps":["trace[893867474] 'process raft request' (duration: 104.388532ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:53:17.856154Z","caller":"traceutil/trace.go:171","msg":"trace[1067497973] transaction","detail":"{read_only:false; response_revision:4601; number_of_response:1; }","duration":"123.4359ms","start":"2026-07-27T10:53:17.732697Z","end":"2026-07-27T10:53:17.856133Z","steps":["trace[1067497973] 'process raft request' (duration: 123.308939ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:53:18.139942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.199429ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-27T10:53:18.140178Z","caller":"traceutil/trace.go:171","msg":"trace[176737562] linearizableReadLoop","detail":"{readStateIndex:4784; appliedIndex:4782; }","duration":"323.579186ms","start":"2026-07-27T10:53:17.816576Z","end":"2026-07-27T10:53:18.140155Z","steps":["trace[176737562] 'read index received' (duration: 39.448433ms)","trace[176737562] 'applied index is now lower than readState.Index' (duration: 284.129503ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T10:53:18.140174Z","caller":"traceutil/trace.go:171","msg":"trace[451944025] transaction","detail":"{read_only:false; response_revision:4602; number_of_response:1; }","duration":"400.600158ms","start":"2026-07-27T10:53:17.739546Z","end":"2026-07-27T10:53:18.140146Z","steps":["trace[451944025] 'process raft request' (duration: 255.097855ms)","trace[451944025] 'compare' (duration: 145.050776ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T10:53:18.140219Z","caller":"traceutil/trace.go:171","msg":"trace[1601095993] transaction","detail":"{read_only:false; response_revision:4603; number_of_response:1; }","duration":"305.431046ms","start":"2026-07-27T10:53:17.834749Z","end":"2026-07-27T10:53:18.14018Z","steps":["trace[1601095993] 'process raft request' (duration: 305.301245ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:53:18.140307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:53:17.739514Z","time spent":"400.724039ms","remote":"127.0.0.1:47748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-27T10:53:18.14031Z","caller":"traceutil/trace.go:171","msg":"trace[26667550] transaction","detail":"{read_only:false; response_revision:4604; number_of_response:1; }","duration":"305.118892ms","start":"2026-07-27T10:53:17.835172Z","end":"2026-07-27T10:53:18.140291Z","steps":["trace[26667550] 'process raft request' (duration: 304.935999ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:53:18.14041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:53:17.834721Z","time spent":"305.583648ms","remote":"127.0.0.1:47748","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-07-27T10:53:18.140444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:53:17.83514Z","time spent":"305.216924ms","remote":"127.0.0.1:47748","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-07-27T10:53:18.140671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.150142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-804cac29-b69e-4281-a5ba-a7d39a0c159a\" ","response":"range_response_count:1 size:4053"} {"level":"info","ts":"2026-07-27T10:53:18.140701Z","caller":"traceutil/trace.go:171","msg":"trace[1426753269] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-804cac29-b69e-4281-a5ba-a7d39a0c159a; range_end:; response_count:1; response_revision:4604; }","duration":"302.220442ms","start":"2026-07-27T10:53:17.838473Z","end":"2026-07-27T10:53:18.140694Z","steps":["trace[1426753269] 'agreement among raft nodes before linearized reading' (duration: 302.08097ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:53:18.140719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:53:17.838458Z","time spent":"302.256382ms","remote":"127.0.0.1:47678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":4076,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-804cac29-b69e-4281-a5ba-a7d39a0c159a\" "} {"level":"warn","ts":"2026-07-27T10:53:18.140926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.354947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-27T10:53:18.140964Z","caller":"traceutil/trace.go:171","msg":"trace[1060513988] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:4604; }","duration":"324.444437ms","start":"2026-07-27T10:53:17.816508Z","end":"2026-07-27T10:53:18.140953Z","steps":["trace[1060513988] 'agreement among raft nodes before linearized reading' (duration: 324.360456ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:53:18.140995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:53:17.816468Z","time spent":"324.519199ms","remote":"127.0.0.1:47812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":25,"response size":30,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"info","ts":"2026-07-27T10:53:20.879475Z","caller":"traceutil/trace.go:171","msg":"trace[1753444054] transaction","detail":"{read_only:false; response_revision:4710; number_of_response:1; }","duration":"122.173377ms","start":"2026-07-27T10:53:20.757252Z","end":"2026-07-27T10:53:20.879426Z","steps":["trace[1753444054] 'process raft request' (duration: 121.502298ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:53:21.110946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.641817ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-27T10:53:21.11138Z","caller":"traceutil/trace.go:171","msg":"trace[981861385] linearizableReadLoop","detail":"{readStateIndex:4896; appliedIndex:4895; }","duration":"161.363204ms","start":"2026-07-27T10:53:20.949987Z","end":"2026-07-27T10:53:21.11135Z","steps":["trace[981861385] 'read index received' (duration: 26.146149ms)","trace[981861385] 'applied index is now lower than readState.Index' (duration: 135.214515ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T10:53:21.111406Z","caller":"traceutil/trace.go:171","msg":"trace[183589103] transaction","detail":"{read_only:false; response_revision:4713; number_of_response:1; }","duration":"153.766199ms","start":"2026-07-27T10:53:20.95761Z","end":"2026-07-27T10:53:21.111376Z","steps":["trace[183589103] 'process raft request' (duration: 153.514226ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:53:21.111394Z","caller":"traceutil/trace.go:171","msg":"trace[856697255] transaction","detail":"{read_only:false; response_revision:4712; number_of_response:1; }","duration":"226.124583ms","start":"2026-07-27T10:53:20.885212Z","end":"2026-07-27T10:53:21.111336Z","steps":["trace[856697255] 'process raft request' (duration: 90.963359ms)","trace[856697255] 'compare' (duration: 134.462894ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T10:53:21.1116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.415657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-07-27T10:53:21.111644Z","caller":"traceutil/trace.go:171","msg":"trace[744603307] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:4714; }","duration":"210.480688ms","start":"2026-07-27T10:53:20.90115Z","end":"2026-07-27T10:53:21.111631Z","steps":["trace[744603307] 'agreement among raft nodes before linearized reading' (duration: 210.277995ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:53:33.841278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.627112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-27T10:53:33.841355Z","caller":"traceutil/trace.go:171","msg":"trace[262076474] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:4869; }","duration":"106.780174ms","start":"2026-07-27T10:53:33.734558Z","end":"2026-07-27T10:53:33.841339Z","steps":["trace[262076474] 'count revisions from in-memory index tree' (duration: 106.421989ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:53:34.373116Z","caller":"traceutil/trace.go:171","msg":"trace[1399247220] transaction","detail":"{read_only:false; response_revision:4875; number_of_response:1; }","duration":"129.5144ms","start":"2026-07-27T10:53:34.243581Z","end":"2026-07-27T10:53:34.373096Z","steps":["trace[1399247220] 'process raft request' (duration: 129.257027ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:53:34.373333Z","caller":"traceutil/trace.go:171","msg":"trace[1730287088] transaction","detail":"{read_only:false; response_revision:4876; number_of_response:1; }","duration":"125.793419ms","start":"2026-07-27T10:53:34.247532Z","end":"2026-07-27T10:53:34.373325Z","steps":["trace[1730287088] 'process raft request' (duration: 125.508035ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:53:34.374168Z","caller":"traceutil/trace.go:171","msg":"trace[74247323] transaction","detail":"{read_only:false; response_revision:4877; number_of_response:1; }","duration":"110.866988ms","start":"2026-07-27T10:53:34.262988Z","end":"2026-07-27T10:53:34.373855Z","steps":["trace[74247323] 'process raft request' (duration: 110.28314ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:54:53.159903Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2860} {"level":"info","ts":"2026-07-27T10:54:53.246367Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2860,"took":"85.046625ms","hash":1501741816,"current-db-size-bytes":52793344,"current-db-size":"53 MB","current-db-size-in-use-bytes":29077504,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-07-27T10:54:53.246422Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1501741816,"revision":2860,"compact-revision":-1} {"level":"warn","ts":"2026-07-27T10:57:16.20347Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11630440085898611337,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-27T10:57:16.460463Z","caller":"traceutil/trace.go:171","msg":"trace[1370097063] linearizableReadLoop","detail":"{readStateIndex:6746; appliedIndex:6745; }","duration":"757.968363ms","start":"2026-07-27T10:57:15.702467Z","end":"2026-07-27T10:57:16.460436Z","steps":["trace[1370097063] 'read index received' (duration: 757.804861ms)","trace[1370097063] 'applied index is now lower than readState.Index' (duration: 161.952µs)"],"step_count":2} {"level":"info","ts":"2026-07-27T10:57:16.46059Z","caller":"traceutil/trace.go:171","msg":"trace[1222564570] transaction","detail":"{read_only:false; response_revision:6502; number_of_response:1; }","duration":"819.780253ms","start":"2026-07-27T10:57:15.640751Z","end":"2026-07-27T10:57:16.460531Z","steps":["trace[1222564570] 'process raft request' (duration: 819.427058ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:57:16.460738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"758.247087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-07-27T10:57:16.460773Z","caller":"traceutil/trace.go:171","msg":"trace[1068154653] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6502; }","duration":"758.367559ms","start":"2026-07-27T10:57:15.702396Z","end":"2026-07-27T10:57:16.460764Z","steps":["trace[1068154653] 'agreement among raft nodes before linearized reading' (duration: 758.199397ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:57:16.460807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:57:15.702375Z","time spent":"758.424059ms","remote":"127.0.0.1:47748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-27T10:57:16.460893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:57:15.640715Z","time spent":"820.018705ms","remote":"127.0.0.1:47678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6488,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-27T10:57:16.461139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"748.038844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-07-27T10:57:16.461265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.650878ms","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-07-27T10:57:16.461304Z","caller":"traceutil/trace.go:171","msg":"trace[690943899] 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:6502; }","duration":"340.76026ms","start":"2026-07-27T10:57:16.120532Z","end":"2026-07-27T10:57:16.461292Z","steps":["trace[690943899] 'agreement among raft nodes before linearized reading' (duration: 340.676849ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:57:16.461333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:57:16.120507Z","time spent":"340.81647ms","remote":"127.0.0.1:47646","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-07-27T10:57:16.461355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.375864ms","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-07-27T10:57:16.461388Z","caller":"traceutil/trace.go:171","msg":"trace[2037880748] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6502; }","duration":"571.446376ms","start":"2026-07-27T10:57:15.889931Z","end":"2026-07-27T10:57:16.461377Z","steps":["trace[2037880748] 'agreement among raft nodes before linearized reading' (duration: 571.353735ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:57:16.461254Z","caller":"traceutil/trace.go:171","msg":"trace[1537389655] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6502; }","duration":"748.218197ms","start":"2026-07-27T10:57:15.713013Z","end":"2026-07-27T10:57:16.461231Z","steps":["trace[1537389655] 'agreement among raft nodes before linearized reading' (duration: 747.938444ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:57:16.461433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:57:15.889911Z","time spent":"571.512096ms","remote":"127.0.0.1:47748","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-07-27T10:57:16.461469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:57:15.713001Z","time spent":"748.458929ms","remote":"127.0.0.1:47748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-27T10:57:16.46169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"724.013838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-07-27T10:57:16.461709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.821522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.219\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-27T10:57:16.461726Z","caller":"traceutil/trace.go:171","msg":"trace[208251876] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6502; }","duration":"724.090558ms","start":"2026-07-27T10:57:15.737626Z","end":"2026-07-27T10:57:16.461717Z","steps":["trace[208251876] 'agreement among raft nodes before linearized reading' (duration: 724.001317ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:57:16.461741Z","caller":"traceutil/trace.go:171","msg":"trace[1876342045] range","detail":"{range_begin:/registry/masterleases/199.19.213.219; range_end:; response_count:1; response_revision:6502; }","duration":"104.853183ms","start":"2026-07-27T10:57:16.356879Z","end":"2026-07-27T10:57:16.461732Z","steps":["trace[1876342045] 'agreement among raft nodes before linearized reading' (duration: 104.768382ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:57:16.461758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:57:15.737579Z","time spent":"724.17294ms","remote":"127.0.0.1:47748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-27T10:57:16.461738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"705.460235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-07-27T10:57:16.461806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.60248ms","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":"warn","ts":"2026-07-27T10:57:16.461189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.012764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-07-27T10:57:16.461931Z","caller":"traceutil/trace.go:171","msg":"trace[343042250] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:6502; }","duration":"213.089076ms","start":"2026-07-27T10:57:16.248821Z","end":"2026-07-27T10:57:16.46191Z","steps":["trace[343042250] 'agreement among raft nodes before linearized reading' (duration: 212.399927ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:57:16.462015Z","caller":"traceutil/trace.go:171","msg":"trace[1710870505] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6502; }","duration":"424.840605ms","start":"2026-07-27T10:57:16.037166Z","end":"2026-07-27T10:57:16.462007Z","steps":["trace[1710870505] 'agreement among raft nodes before linearized reading' (duration: 423.954054ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:57:16.46204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:57:16.037093Z","time spent":"424.941256ms","remote":"127.0.0.1:47678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12236,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-07-27T10:57:16.46182Z","caller":"traceutil/trace.go:171","msg":"trace[1014801676] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6502; }","duration":"705.620328ms","start":"2026-07-27T10:57:15.756182Z","end":"2026-07-27T10:57:16.461802Z","steps":["trace[1014801676] 'agreement among raft nodes before linearized reading' (duration: 705.268254ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:57:16.462224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:57:15.756155Z","time spent":"706.017174ms","remote":"127.0.0.1:47748","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":"info","ts":"2026-07-27T10:57:16.949955Z","caller":"traceutil/trace.go:171","msg":"trace[1324248884] transaction","detail":"{read_only:false; response_revision:6504; number_of_response:1; }","duration":"482.162549ms","start":"2026-07-27T10:57:16.467741Z","end":"2026-07-27T10:57:16.949903Z","steps":["trace[1324248884] 'process raft request' (duration: 481.803055ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:57:16.950061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:57:16.467797Z","time spent":"482.259709ms","remote":"127.0.0.1:47528","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-07-27T10:57:16.950175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:57:16.467712Z","time spent":"482.34487ms","remote":"127.0.0.1:47748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-27T10:57:16.951767Z","caller":"traceutil/trace.go:171","msg":"trace[1378662349] transaction","detail":"{read_only:false; response_revision:6506; number_of_response:1; }","duration":"478.845529ms","start":"2026-07-27T10:57:16.472891Z","end":"2026-07-27T10:57:16.951736Z","steps":["trace[1378662349] 'process raft request' (duration: 478.714728ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:57:16.952006Z","caller":"traceutil/trace.go:171","msg":"trace[1974728365] linearizableReadLoop","detail":"{readStateIndex:6751; appliedIndex:6746; }","duration":"478.903921ms","start":"2026-07-27T10:57:16.473051Z","end":"2026-07-27T10:57:16.951955Z","steps":["trace[1974728365] 'read index received' (duration: 60.235989ms)","trace[1974728365] 'applied index is now lower than readState.Index' (duration: 418.666582ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T10:57:16.952042Z","caller":"traceutil/trace.go:171","msg":"trace[558211784] transaction","detail":"{read_only:false; response_revision:6507; number_of_response:1; }","duration":"478.608996ms","start":"2026-07-27T10:57:16.473415Z","end":"2026-07-27T10:57:16.952024Z","steps":["trace[558211784] 'process raft request' (duration: 478.261501ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:57:16.952124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:57:16.473403Z","time spent":"478.683707ms","remote":"127.0.0.1:47748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-27T10:57:16.952155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:57:16.472875Z","time spent":"478.98438ms","remote":"127.0.0.1:47748","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-07-27T10:57:16.952242Z","caller":"traceutil/trace.go:171","msg":"trace[488149014] transaction","detail":"{read_only:false; response_revision:6505; number_of_response:1; }","duration":"479.008481ms","start":"2026-07-27T10:57:16.472883Z","end":"2026-07-27T10:57:16.951891Z","steps":["trace[488149014] 'process raft request' (duration: 477.014987ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:57:16.952291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.234614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-07-27T10:57:16.95237Z","caller":"traceutil/trace.go:171","msg":"trace[1619315824] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6507; }","duration":"479.367036ms","start":"2026-07-27T10:57:16.472987Z","end":"2026-07-27T10:57:16.952354Z","steps":["trace[1619315824] 'agreement among raft nodes before linearized reading' (duration: 479.081833ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:57:16.952367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:57:16.472853Z","time spent":"479.478567ms","remote":"127.0.0.1:47748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-27T10:57:16.952453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:57:16.472958Z","time spent":"479.457477ms","remote":"127.0.0.1:47678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12236,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-07-27T10:57:16.967375Z","caller":"traceutil/trace.go:171","msg":"trace[1292904712] transaction","detail":"{read_only:false; response_revision:6508; number_of_response:1; }","duration":"133.092151ms","start":"2026-07-27T10:57:16.834269Z","end":"2026-07-27T10:57:16.967361Z","steps":["trace[1292904712] 'process raft request' (duration: 132.830467ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:57:16.967623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.230963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-804cac29-b69e-4281-a5ba-a7d39a0c159a\" ","response":"range_response_count:1 size:1435"} {"level":"info","ts":"2026-07-27T10:57:16.967648Z","caller":"traceutil/trace.go:171","msg":"trace[103043906] range","detail":"{range_begin:/registry/persistentvolumes/pvc-804cac29-b69e-4281-a5ba-a7d39a0c159a; range_end:; response_count:1; response_revision:6509; }","duration":"494.273464ms","start":"2026-07-27T10:57:16.473365Z","end":"2026-07-27T10:57:16.967639Z","steps":["trace[103043906] 'agreement among raft nodes before linearized reading' (duration: 494.185413ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:57:16.967667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:57:16.473359Z","time spent":"494.303804ms","remote":"127.0.0.1:47632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1458,"request content":"key:\"/registry/persistentvolumes/pvc-804cac29-b69e-4281-a5ba-a7d39a0c159a\" "} {"level":"warn","ts":"2026-07-27T10:57:16.967673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.150711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-27T10:57:16.967716Z","caller":"traceutil/trace.go:171","msg":"trace[1754187941] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6509; }","duration":"303.242942ms","start":"2026-07-27T10:57:16.66446Z","end":"2026-07-27T10:57:16.967703Z","steps":["trace[1754187941] 'agreement among raft nodes before linearized reading' (duration: 303.179882ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:57:16.967747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:57:16.664435Z","time spent":"303.304933ms","remote":"127.0.0.1:47482","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-07-27T10:57:16.967818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.570432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4859"} {"level":"info","ts":"2026-07-27T10:57:16.967836Z","caller":"traceutil/trace.go:171","msg":"trace[1010881825] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6509; }","duration":"388.641873ms","start":"2026-07-27T10:57:16.579189Z","end":"2026-07-27T10:57:16.967831Z","steps":["trace[1010881825] 'agreement among raft nodes before linearized reading' (duration: 388.575802ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:57:16.967853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T10:57:16.57916Z","time spent":"388.689383ms","remote":"127.0.0.1:47718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":4882,"request content":"key:\"/registry/jobs/openstack/horizon-db-sync\" "} {"level":"warn","ts":"2026-07-27T10:57:16.968299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.468962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4859"} {"level":"info","ts":"2026-07-27T10:57:16.968349Z","caller":"traceutil/trace.go:171","msg":"trace[1491543769] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6509; }","duration":"204.562383ms","start":"2026-07-27T10:57:16.763773Z","end":"2026-07-27T10:57:16.968335Z","steps":["trace[1491543769] 'agreement among raft nodes before linearized reading' (duration: 203.55837ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:57:16.968445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.598536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4859"} {"level":"info","ts":"2026-07-27T10:57:16.968514Z","caller":"traceutil/trace.go:171","msg":"trace[1003249502] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6509; }","duration":"231.721937ms","start":"2026-07-27T10:57:16.736773Z","end":"2026-07-27T10:57:16.968495Z","steps":["trace[1003249502] 'agreement among raft nodes before linearized reading' (duration: 230.563273ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:57:21.138344Z","caller":"traceutil/trace.go:171","msg":"trace[481146822] linearizableReadLoop","detail":"{readStateIndex:6773; appliedIndex:6769; }","duration":"155.000247ms","start":"2026-07-27T10:57:20.983316Z","end":"2026-07-27T10:57:21.138316Z","steps":["trace[481146822] 'read index received' (duration: 12.894121ms)","trace[481146822] 'applied index is now lower than readState.Index' (duration: 142.105076ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T10:57:21.138488Z","caller":"traceutil/trace.go:171","msg":"trace[1021802074] transaction","detail":"{read_only:false; response_revision:6527; number_of_response:1; }","duration":"166.221879ms","start":"2026-07-27T10:57:20.972217Z","end":"2026-07-27T10:57:21.138438Z","steps":["trace[1021802074] 'process raft request' (duration: 165.967521ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:57:21.138739Z","caller":"traceutil/trace.go:171","msg":"trace[1622685355] transaction","detail":"{read_only:false; response_revision:6526; number_of_response:1; }","duration":"166.559089ms","start":"2026-07-27T10:57:20.972115Z","end":"2026-07-27T10:57:21.138674Z","steps":["trace[1622685355] 'process raft request' (duration: 165.900159ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:57:21.138885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.532104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4859"} {"level":"warn","ts":"2026-07-27T10:57:21.138978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.265305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4859"} {"level":"info","ts":"2026-07-27T10:57:21.138536Z","caller":"traceutil/trace.go:171","msg":"trace[1788618151] transaction","detail":"{read_only:false; response_revision:6528; number_of_response:1; }","duration":"163.845756ms","start":"2026-07-27T10:57:20.974608Z","end":"2026-07-27T10:57:21.138453Z","steps":["trace[1788618151] 'process raft request' (duration: 163.620679ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:57:21.139281Z","caller":"traceutil/trace.go:171","msg":"trace[1699206475] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6529; }","duration":"152.621795ms","start":"2026-07-27T10:57:20.986641Z","end":"2026-07-27T10:57:21.139263Z","steps":["trace[1699206475] 'agreement among raft nodes before linearized reading' (duration: 152.081129ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:57:21.138487Z","caller":"traceutil/trace.go:171","msg":"trace[250026402] transaction","detail":"{read_only:false; response_revision:6529; number_of_response:1; }","duration":"153.462301ms","start":"2026-07-27T10:57:20.985013Z","end":"2026-07-27T10:57:21.138475Z","steps":["trace[250026402] 'process raft request' (duration: 153.262694ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:57:21.139279Z","caller":"traceutil/trace.go:171","msg":"trace[910581252] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6529; }","duration":"155.981647ms","start":"2026-07-27T10:57:20.983268Z","end":"2026-07-27T10:57:21.139249Z","steps":["trace[910581252] 'agreement among raft nodes before linearized reading' (duration: 155.388929ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T10:57:21.138923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.491993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4859"} {"level":"info","ts":"2026-07-27T10:57:21.139754Z","caller":"traceutil/trace.go:171","msg":"trace[303009264] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6529; }","duration":"154.334397ms","start":"2026-07-27T10:57:20.985398Z","end":"2026-07-27T10:57:21.139732Z","steps":["trace[303009264] 'agreement among raft nodes before linearized reading' (duration: 153.256645ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T10:59:53.168433Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5530} {"level":"info","ts":"2026-07-27T10:59:53.291528Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5530,"took":"119.034971ms","hash":817543775,"current-db-size-bytes":52793344,"current-db-size":"53 MB","current-db-size-in-use-bytes":18288640,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-27T10:59:53.291714Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":817543775,"revision":5530,"compact-revision":2860}