{"level":"warn","ts":"2026-04-09T06:01:00.556294Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-09T06:01:00.556431Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.118: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.118:2380","--initial-cluster=instance=https://199.19.213.118:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.118:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.118:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-09T06:01:00.556519Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-09T06:01:00.556539Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.118:2380"]} {"level":"info","ts":"2026-04-09T06:01:00.556567Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-09T06:01:00.557355Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.118:2379"]} {"level":"info","ts":"2026-04-09T06:01:00.55759Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.118:2380"],"listen-peer-urls":["https://199.19.213.118:2380"],"advertise-client-urls":["https://199.19.213.118:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.118:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.118:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-09T06:01:00.561331Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.384581ms"} {"level":"info","ts":"2026-04-09T06:01:00.582352Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"511d8c552db01fa8","cluster-id":"8d545d29b73b98f3"} {"level":"info","ts":"2026-04-09T06:01:00.582417Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 switched to configuration voters=()"} {"level":"info","ts":"2026-04-09T06:01:00.582435Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 became follower at term 0"} {"level":"info","ts":"2026-04-09T06:01:00.582446Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 511d8c552db01fa8 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-09T06:01:00.582453Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 became follower at term 1"} {"level":"info","ts":"2026-04-09T06:01:00.582484Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 switched to configuration voters=(5844982188863397800)"} {"level":"warn","ts":"2026-04-09T06:01:00.59938Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-09T06:01:00.603271Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-09T06:01:00.604886Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-09T06:01:00.607331Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"511d8c552db01fa8","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-09T06:01:00.607569Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"511d8c552db01fa8","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-09T06:01:00.607704Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-09T06:01:00.607861Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-09T06:01:00.607907Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-09T06:01:00.608661Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 switched to configuration voters=(5844982188863397800)"} {"level":"info","ts":"2026-04-09T06:01:00.608856Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8d545d29b73b98f3","local-member-id":"511d8c552db01fa8","added-peer-id":"511d8c552db01fa8","added-peer-peer-urls":["https://199.19.213.118:2380"]} {"level":"info","ts":"2026-04-09T06:01:00.610377Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-09T06:01:00.610496Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.118:2380"} {"level":"info","ts":"2026-04-09T06:01:00.610604Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.118:2380"} {"level":"info","ts":"2026-04-09T06:01:00.610688Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"511d8c552db01fa8","initial-advertise-peer-urls":["https://199.19.213.118:2380"],"listen-peer-urls":["https://199.19.213.118:2380"],"advertise-client-urls":["https://199.19.213.118:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.118:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-09T06:01:00.610755Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-09T06:01:00.883544Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 is starting a new election at term 1"} {"level":"info","ts":"2026-04-09T06:01:00.883654Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-09T06:01:00.883684Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 received MsgPreVoteResp from 511d8c552db01fa8 at term 1"} {"level":"info","ts":"2026-04-09T06:01:00.883717Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 became candidate at term 2"} {"level":"info","ts":"2026-04-09T06:01:00.883734Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 received MsgVoteResp from 511d8c552db01fa8 at term 2"} {"level":"info","ts":"2026-04-09T06:01:00.883754Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 became leader at term 2"} {"level":"info","ts":"2026-04-09T06:01:00.883773Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 511d8c552db01fa8 elected leader 511d8c552db01fa8 at term 2"} {"level":"info","ts":"2026-04-09T06:01:00.885198Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"511d8c552db01fa8","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.118:2379]}","request-path":"/0/members/511d8c552db01fa8/attributes","cluster-id":"8d545d29b73b98f3","publish-timeout":"7s"} {"level":"info","ts":"2026-04-09T06:01:00.88525Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-09T06:01:00.885377Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-09T06:01:00.885391Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T06:01:00.885544Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-09T06:01:00.885584Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-09T06:01:00.887077Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8d545d29b73b98f3","local-member-id":"511d8c552db01fa8","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T06:01:00.887334Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T06:01:00.887408Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T06:01:00.888863Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-09T06:01:00.889654Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.118:2379"} {"level":"info","ts":"2026-04-09T06:01:19.886538Z","caller":"traceutil/trace.go:171","msg":"trace[1603095841] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"184.854266ms","start":"2026-04-09T06:01:19.701654Z","end":"2026-04-09T06:01:19.886508Z","steps":["trace[1603095841] 'process raft request' (duration: 184.685162ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:30.613227Z","caller":"traceutil/trace.go:171","msg":"trace[546295830] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"144.271875ms","start":"2026-04-09T06:01:30.468924Z","end":"2026-04-09T06:01:30.613196Z","steps":["trace[546295830] 'process raft request' (duration: 144.063469ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:30.613274Z","caller":"traceutil/trace.go:171","msg":"trace[2025750853] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"142.522013ms","start":"2026-04-09T06:01:30.470717Z","end":"2026-04-09T06:01:30.613239Z","steps":["trace[2025750853] 'process raft request' (duration: 142.385309ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:30.613341Z","caller":"traceutil/trace.go:171","msg":"trace[878626058] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"142.479842ms","start":"2026-04-09T06:01:30.470796Z","end":"2026-04-09T06:01:30.613276Z","steps":["trace[878626058] 'process raft request' (duration: 142.344389ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:30.613597Z","caller":"traceutil/trace.go:171","msg":"trace[2131094571] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"132.563725ms","start":"2026-04-09T06:01:30.481017Z","end":"2026-04-09T06:01:30.613581Z","steps":["trace[2131094571] 'process raft request' (duration: 132.285919ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:30.613616Z","caller":"traceutil/trace.go:171","msg":"trace[870881841] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"133.423665ms","start":"2026-04-09T06:01:30.480175Z","end":"2026-04-09T06:01:30.613599Z","steps":["trace[870881841] 'process raft request' (duration: 133.015016ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:30.61364Z","caller":"traceutil/trace.go:171","msg":"trace[1153970852] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"132.902513ms","start":"2026-04-09T06:01:30.480723Z","end":"2026-04-09T06:01:30.613626Z","steps":["trace[1153970852] 'process raft request' (duration: 132.517534ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:30.613617Z","caller":"traceutil/trace.go:171","msg":"trace[507384344] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"114.679306ms","start":"2026-04-09T06:01:30.498912Z","end":"2026-04-09T06:01:30.613591Z","steps":["trace[507384344] 'process raft request' (duration: 114.576184ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:30.613731Z","caller":"traceutil/trace.go:171","msg":"trace[2082738136] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"132.185955ms","start":"2026-04-09T06:01:30.481532Z","end":"2026-04-09T06:01:30.613718Z","steps":["trace[2082738136] 'process raft request' (duration: 131.847147ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:30.613735Z","caller":"traceutil/trace.go:171","msg":"trace[2099563905] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"132.710018ms","start":"2026-04-09T06:01:30.481015Z","end":"2026-04-09T06:01:30.613725Z","steps":["trace[2099563905] 'process raft request' (duration: 132.328009ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:30.613843Z","caller":"traceutil/trace.go:171","msg":"trace[736600295] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"125.761192ms","start":"2026-04-09T06:01:30.488014Z","end":"2026-04-09T06:01:30.613776Z","steps":["trace[736600295] 'process raft request' (duration: 125.408533ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:36.903438Z","caller":"traceutil/trace.go:171","msg":"trace[667194775] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"351.710865ms","start":"2026-04-09T06:01:36.551698Z","end":"2026-04-09T06:01:36.903409Z","steps":["trace[667194775] 'process raft request' (duration: 350.199288ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:01:36.904036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:01:36.55163Z","time spent":"351.895049ms","remote":"127.0.0.1:40032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-09T06:01:37.122035Z","caller":"traceutil/trace.go:171","msg":"trace[2040925960] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"171.226032ms","start":"2026-04-09T06:01:36.95078Z","end":"2026-04-09T06:01:37.122006Z","steps":["trace[2040925960] 'process raft request' (duration: 171.014677ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:01:37.766565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.599793ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-09T06:01:37.766783Z","caller":"traceutil/trace.go:171","msg":"trace[527530382] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:637; }","duration":"505.635753ms","start":"2026-04-09T06:01:37.261108Z","end":"2026-04-09T06:01:37.766744Z","steps":["trace[527530382] 'read index received' (duration: 29.421µs)","trace[527530382] 'applied index is now lower than readState.Index' (duration: 505.604162ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:01:37.766815Z","caller":"traceutil/trace.go:171","msg":"trace[1920791122] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"802.779707ms","start":"2026-04-09T06:01:36.963981Z","end":"2026-04-09T06:01:37.766761Z","steps":["trace[1920791122] 'process raft request' (duration: 296.58904ms)","trace[1920791122] 'compare' (duration: 505.295566ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:01:37.767035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:01:36.963967Z","time spent":"802.963571ms","remote":"127.0.0.1:40448","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-04-09T06:01:37.767101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.982101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-09T06:01:37.767148Z","caller":"traceutil/trace.go:171","msg":"trace[1435534214] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:618; }","duration":"506.082973ms","start":"2026-04-09T06:01:37.261052Z","end":"2026-04-09T06:01:37.767135Z","steps":["trace[1435534214] 'agreement among raft nodes before linearized reading' (duration: 505.827497ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:01:37.767205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:01:37.261026Z","time spent":"506.167635ms","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-09T06:01:37.767186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.477818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-09T06:01:37.767253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.751756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-09T06:01:37.767326Z","caller":"traceutil/trace.go:171","msg":"trace[1568100511] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:618; }","duration":"442.691223ms","start":"2026-04-09T06:01:37.324601Z","end":"2026-04-09T06:01:37.767293Z","steps":["trace[1568100511] 'agreement among raft nodes before linearized reading' (duration: 442.444447ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:01:37.767352Z","caller":"traceutil/trace.go:171","msg":"trace[2002692561] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:618; }","duration":"505.883769ms","start":"2026-04-09T06:01:37.261446Z","end":"2026-04-09T06:01:37.76733Z","steps":["trace[2002692561] 'agreement among raft nodes before linearized reading' (duration: 505.574742ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:01:37.767387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:01:37.324574Z","time spent":"442.802976ms","remote":"127.0.0.1:39918","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-04-09T06:01:37.767405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:01:37.261435Z","time spent":"505.95664ms","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-09T06:01:50.073656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.422674ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-09T06:01:50.074353Z","caller":"traceutil/trace.go:171","msg":"trace[678223193] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"216.816228ms","start":"2026-04-09T06:01:49.857081Z","end":"2026-04-09T06:01:50.073897Z","steps":["trace[678223193] 'process raft request' (duration: 90.072357ms)","trace[678223193] 'compare' (duration: 126.297191ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:01:52.893204Z","caller":"traceutil/trace.go:171","msg":"trace[148018448] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"201.645507ms","start":"2026-04-09T06:01:52.691484Z","end":"2026-04-09T06:01:52.893129Z","steps":["trace[148018448] 'process raft request' (duration: 201.479403ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:02:20.326551Z","caller":"traceutil/trace.go:171","msg":"trace[77584570] transaction","detail":"{read_only:false; response_revision:1173; number_of_response:1; }","duration":"106.230463ms","start":"2026-04-09T06:02:20.220288Z","end":"2026-04-09T06:02:20.326519Z","steps":["trace[77584570] 'process raft request' (duration: 105.900454ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:02:20.917655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.015184ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-09T06:02:20.917955Z","caller":"traceutil/trace.go:171","msg":"trace[1361582052] transaction","detail":"{read_only:false; response_revision:1174; number_of_response:1; }","duration":"586.86356ms","start":"2026-04-09T06:02:20.331072Z","end":"2026-04-09T06:02:20.917936Z","steps":["trace[1361582052] 'process raft request' (duration: 257.478337ms)","trace[1361582052] 'compare' (duration: 328.796558ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:02:20.918061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:02:20.331056Z","time spent":"586.941802ms","remote":"127.0.0.1:40212","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-04-09T06:03:05.268361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.302642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-09T06:03:05.268478Z","caller":"traceutil/trace.go:171","msg":"trace[1462443080] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1843; }","duration":"259.472367ms","start":"2026-04-09T06:03:05.008983Z","end":"2026-04-09T06:03:05.268456Z","steps":["trace[1462443080] 'count revisions from in-memory index tree' (duration: 259.21296ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:03:05.268484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.638626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-09T06:03:05.268549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.054827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:03:05.268582Z","caller":"traceutil/trace.go:171","msg":"trace[811080632] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1843; }","duration":"194.8228ms","start":"2026-04-09T06:03:05.073739Z","end":"2026-04-09T06:03:05.268562Z","steps":["trace[811080632] 'count revisions from in-memory index tree' (duration: 194.502492ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:03:05.268636Z","caller":"traceutil/trace.go:171","msg":"trace[1386081592] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:1843; }","duration":"297.214369ms","start":"2026-04-09T06:03:04.971403Z","end":"2026-04-09T06:03:05.268617Z","steps":["trace[1386081592] 'count revisions from in-memory index tree' (duration: 296.849791ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:03:05.268674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.736457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:03:05.26875Z","caller":"traceutil/trace.go:171","msg":"trace[1302159544] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1843; }","duration":"288.876931ms","start":"2026-04-09T06:03:04.979851Z","end":"2026-04-09T06:03:05.268728Z","steps":["trace[1302159544] 'range keys from in-memory index tree' (duration: 288.612614ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:03:05.544556Z","caller":"traceutil/trace.go:171","msg":"trace[1124948002] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"130.382839ms","start":"2026-04-09T06:03:05.41414Z","end":"2026-04-09T06:03:05.544523Z","steps":["trace[1124948002] 'process raft request' (duration: 130.158214ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:03:05.789559Z","caller":"traceutil/trace.go:171","msg":"trace[691992895] linearizableReadLoop","detail":"{readStateIndex:1916; appliedIndex:1914; }","duration":"179.980115ms","start":"2026-04-09T06:03:05.609547Z","end":"2026-04-09T06:03:05.789527Z","steps":["trace[691992895] 'read index received' (duration: 145.991622ms)","trace[691992895] 'applied index is now lower than readState.Index' (duration: 33.987243ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:03:05.789586Z","caller":"traceutil/trace.go:171","msg":"trace[117189723] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"238.968777ms","start":"2026-04-09T06:03:05.550586Z","end":"2026-04-09T06:03:05.789555Z","steps":["trace[117189723] 'process raft request' (duration: 204.933753ms)","trace[117189723] 'compare' (duration: 33.779498ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:03:05.789622Z","caller":"traceutil/trace.go:171","msg":"trace[1669987183] transaction","detail":"{read_only:false; response_revision:1848; number_of_response:1; }","duration":"219.223704ms","start":"2026-04-09T06:03:05.570351Z","end":"2026-04-09T06:03:05.789574Z","steps":["trace[1669987183] 'process raft request' (duration: 219.111172ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:03:05.789923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.365596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:03:05.789971Z","caller":"traceutil/trace.go:171","msg":"trace[1537084037] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1848; }","duration":"180.481878ms","start":"2026-04-09T06:03:05.609476Z","end":"2026-04-09T06:03:05.789958Z","steps":["trace[1537084037] 'agreement among raft nodes before linearized reading' (duration: 180.383925ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:03:18.182091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.269551ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-09T06:03:18.182349Z","caller":"traceutil/trace.go:171","msg":"trace[25300686] transaction","detail":"{read_only:false; response_revision:1950; number_of_response:1; }","duration":"325.575168ms","start":"2026-04-09T06:03:17.856745Z","end":"2026-04-09T06:03:18.18232Z","steps":["trace[25300686] 'process raft request' (duration: 180.99993ms)","trace[25300686] 'compare' (duration: 144.126938ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:03:18.182559Z","caller":"traceutil/trace.go:171","msg":"trace[467223464] transaction","detail":"{read_only:false; response_revision:1951; number_of_response:1; }","duration":"191.382528ms","start":"2026-04-09T06:03:17.991158Z","end":"2026-04-09T06:03:18.18254Z","steps":["trace[467223464] 'process raft request' (duration: 191.02782ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:03:18.182608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:03:17.856723Z","time spent":"325.730502ms","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-09T06:03:18.424594Z","caller":"traceutil/trace.go:171","msg":"trace[950190047] linearizableReadLoop","detail":"{readStateIndex:2024; appliedIndex:2023; }","duration":"129.736325ms","start":"2026-04-09T06:03:18.294835Z","end":"2026-04-09T06:03:18.424571Z","steps":["trace[950190047] 'read index received' (duration: 129.599491ms)","trace[950190047] 'applied index is now lower than readState.Index' (duration: 135.704µs)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:03:18.424628Z","caller":"traceutil/trace.go:171","msg":"trace[1676942163] transaction","detail":"{read_only:false; response_revision:1952; number_of_response:1; }","duration":"132.584472ms","start":"2026-04-09T06:03:18.292016Z","end":"2026-04-09T06:03:18.424601Z","steps":["trace[1676942163] 'process raft request' (duration: 132.422089ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:03:18.424777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.938449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-09T06:03:18.424817Z","caller":"traceutil/trace.go:171","msg":"trace[1945815503] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1952; }","duration":"130.031711ms","start":"2026-04-09T06:03:18.294776Z","end":"2026-04-09T06:03:18.424807Z","steps":["trace[1945815503] 'agreement among raft nodes before linearized reading' (duration: 129.904238ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:03:18.464745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.000139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:03:18.464789Z","caller":"traceutil/trace.go:171","msg":"trace[521427659] transaction","detail":"{read_only:false; response_revision:1953; number_of_response:1; }","duration":"166.846052ms","start":"2026-04-09T06:03:18.297918Z","end":"2026-04-09T06:03:18.464764Z","steps":["trace[521427659] 'process raft request' (duration: 166.666228ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:03:18.464831Z","caller":"traceutil/trace.go:171","msg":"trace[819893896] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1953; }","duration":"140.118962ms","start":"2026-04-09T06:03:18.324681Z","end":"2026-04-09T06:03:18.4648Z","steps":["trace[819893896] 'agreement among raft nodes before linearized reading' (duration: 139.999699ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:03:18.557084Z","caller":"traceutil/trace.go:171","msg":"trace[1321329192] transaction","detail":"{read_only:false; response_revision:1954; number_of_response:1; }","duration":"128.050844ms","start":"2026-04-09T06:03:18.429004Z","end":"2026-04-09T06:03:18.557055Z","steps":["trace[1321329192] 'process raft request' (duration: 99.196914ms)","trace[1321329192] 'compare' (duration: 28.637415ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:03:22.087977Z","caller":"traceutil/trace.go:171","msg":"trace[1810483256] transaction","detail":"{read_only:false; response_revision:1981; number_of_response:1; }","duration":"252.563712ms","start":"2026-04-09T06:03:21.83539Z","end":"2026-04-09T06:03:22.087954Z","steps":["trace[1810483256] 'process raft request' (duration: 251.965988ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:03:55.010645Z","caller":"traceutil/trace.go:171","msg":"trace[523456653] linearizableReadLoop","detail":"{readStateIndex:2244; appliedIndex:2243; }","duration":"125.684593ms","start":"2026-04-09T06:03:54.884937Z","end":"2026-04-09T06:03:55.010622Z","steps":["trace[523456653] 'read index received' (duration: 87.141889ms)","trace[523456653] 'applied index is now lower than readState.Index' (duration: 38.541744ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:03:55.010688Z","caller":"traceutil/trace.go:171","msg":"trace[79726846] transaction","detail":"{read_only:false; response_revision:2164; number_of_response:1; }","duration":"189.433763ms","start":"2026-04-09T06:03:54.821218Z","end":"2026-04-09T06:03:55.010652Z","steps":["trace[79726846] 'process raft request' (duration: 150.857048ms)","trace[79726846] 'compare' (duration: 38.420551ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:03:55.010928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.985751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-09T06:03:55.011039Z","caller":"traceutil/trace.go:171","msg":"trace[2069544602] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2164; }","duration":"126.088533ms","start":"2026-04-09T06:03:54.884875Z","end":"2026-04-09T06:03:55.010964Z","steps":["trace[2069544602] 'agreement among raft nodes before linearized reading' (duration: 125.859587ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:03:55.609062Z","caller":"traceutil/trace.go:171","msg":"trace[1448911355] transaction","detail":"{read_only:false; response_revision:2165; number_of_response:1; }","duration":"192.399662ms","start":"2026-04-09T06:03:55.416641Z","end":"2026-04-09T06:03:55.609041Z","steps":["trace[1448911355] 'process raft request' (duration: 192.245087ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:04:01.207643Z","caller":"traceutil/trace.go:171","msg":"trace[696599685] linearizableReadLoop","detail":"{readStateIndex:2278; appliedIndex:2277; }","duration":"154.364861ms","start":"2026-04-09T06:04:01.053239Z","end":"2026-04-09T06:04:01.207604Z","steps":["trace[696599685] 'read index received' (duration: 154.093764ms)","trace[696599685] 'applied index is now lower than readState.Index' (duration: 269.827µs)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:04:01.207758Z","caller":"traceutil/trace.go:171","msg":"trace[768142727] transaction","detail":"{read_only:false; response_revision:2197; number_of_response:1; }","duration":"171.224554ms","start":"2026-04-09T06:04:01.036495Z","end":"2026-04-09T06:04:01.207719Z","steps":["trace[768142727] 'process raft request' (duration: 170.852994ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:04:01.207974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.70748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-09T06:04:01.208031Z","caller":"traceutil/trace.go:171","msg":"trace[2050813805] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2197; }","duration":"154.837874ms","start":"2026-04-09T06:04:01.053179Z","end":"2026-04-09T06:04:01.208016Z","steps":["trace[2050813805] 'agreement among raft nodes before linearized reading' (duration: 154.619059ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:04:01.777663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.120573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-09T06:04:01.777818Z","caller":"traceutil/trace.go:171","msg":"trace[1570541673] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2197; }","duration":"120.346779ms","start":"2026-04-09T06:04:01.657447Z","end":"2026-04-09T06:04:01.777793Z","steps":["trace[1570541673] 'range keys from in-memory index tree' (duration: 119.910457ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:04:01.777911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.997941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:04:01.778021Z","caller":"traceutil/trace.go:171","msg":"trace[1449446471] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2197; }","duration":"454.170395ms","start":"2026-04-09T06:04:01.323822Z","end":"2026-04-09T06:04:01.777993Z","steps":["trace[1449446471] 'range keys from in-memory index tree' (duration: 453.896588ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:04:01.778074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:04:01.323796Z","time spent":"454.264148ms","remote":"127.0.0.1:39918","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-04-09T06:04:01.778109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.214208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-09T06:04:01.778194Z","caller":"traceutil/trace.go:171","msg":"trace[1686605998] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2197; }","duration":"138.345731ms","start":"2026-04-09T06:04:01.639815Z","end":"2026-04-09T06:04:01.778161Z","steps":["trace[1686605998] 'range keys from in-memory index tree' (duration: 138.017303ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:04:01.778369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.189158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:04:01.778401Z","caller":"traceutil/trace.go:171","msg":"trace[1194644739] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:2197; }","duration":"160.26563ms","start":"2026-04-09T06:04:01.618125Z","end":"2026-04-09T06:04:01.778391Z","steps":["trace[1194644739] 'count revisions from in-memory index tree' (duration: 160.018644ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:04:01.978527Z","caller":"traceutil/trace.go:171","msg":"trace[1810834401] transaction","detail":"{read_only:false; response_revision:2198; number_of_response:1; }","duration":"196.506132ms","start":"2026-04-09T06:04:01.78199Z","end":"2026-04-09T06:04:01.978496Z","steps":["trace[1810834401] 'process raft request' (duration: 196.202044ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:04:02.023253Z","caller":"traceutil/trace.go:171","msg":"trace[1612992859] transaction","detail":"{read_only:false; response_revision:2199; number_of_response:1; }","duration":"241.197741ms","start":"2026-04-09T06:04:01.782033Z","end":"2026-04-09T06:04:02.023231Z","steps":["trace[1612992859] 'process raft request' (duration: 241.078648ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:05:17.453247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.529928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:05:17.453351Z","caller":"traceutil/trace.go:171","msg":"trace[1360328677] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2805; }","duration":"128.799065ms","start":"2026-04-09T06:05:17.32453Z","end":"2026-04-09T06:05:17.453329Z","steps":["trace[1360328677] 'range keys from in-memory index tree' (duration: 128.449466ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:05:17.776234Z","caller":"traceutil/trace.go:171","msg":"trace[339517040] transaction","detail":"{read_only:false; response_revision:2806; number_of_response:1; }","duration":"150.606553ms","start":"2026-04-09T06:05:17.6256Z","end":"2026-04-09T06:05:17.776206Z","steps":["trace[339517040] 'process raft request' (duration: 150.426938ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:09:03.480572Z","caller":"traceutil/trace.go:171","msg":"trace[1784705734] transaction","detail":"{read_only:false; response_revision:4834; number_of_response:1; }","duration":"180.287184ms","start":"2026-04-09T06:09:03.30025Z","end":"2026-04-09T06:09:03.480537Z","steps":["trace[1784705734] 'process raft request' (duration: 180.003587ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:09:03.480619Z","caller":"traceutil/trace.go:171","msg":"trace[1864007845] linearizableReadLoop","detail":"{readStateIndex:5017; appliedIndex:5014; }","duration":"158.513831ms","start":"2026-04-09T06:09:03.322083Z","end":"2026-04-09T06:09:03.480596Z","steps":["trace[1864007845] 'read index received' (duration: 8.986429ms)","trace[1864007845] 'applied index is now lower than readState.Index' (duration: 149.526292ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:09:03.480713Z","caller":"traceutil/trace.go:171","msg":"trace[1995701222] transaction","detail":"{read_only:false; response_revision:4835; number_of_response:1; }","duration":"167.745688ms","start":"2026-04-09T06:09:03.31296Z","end":"2026-04-09T06:09:03.480706Z","steps":["trace[1995701222] 'process raft request' (duration: 167.467951ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:09:03.480918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.813618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-04-09T06:09:03.481Z","caller":"traceutil/trace.go:171","msg":"trace[1953704643] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4835; }","duration":"158.91601ms","start":"2026-04-09T06:09:03.322061Z","end":"2026-04-09T06:09:03.480977Z","steps":["trace[1953704643] 'agreement among raft nodes before linearized reading' (duration: 158.705445ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:09:03.500578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.410606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:9 size:75477"} {"level":"info","ts":"2026-04-09T06:09:03.500643Z","caller":"traceutil/trace.go:171","msg":"trace[627729574] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:9; response_revision:4837; }","duration":"178.485788ms","start":"2026-04-09T06:09:03.322143Z","end":"2026-04-09T06:09:03.500629Z","steps":["trace[627729574] 'agreement among raft nodes before linearized reading' (duration: 178.227132ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:09:03.500691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.142119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-04-09T06:09:03.500764Z","caller":"traceutil/trace.go:171","msg":"trace[1015370217] 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:4837; }","duration":"155.227302ms","start":"2026-04-09T06:09:03.345517Z","end":"2026-04-09T06:09:03.500745Z","steps":["trace[1015370217] 'agreement among raft nodes before linearized reading' (duration: 155.021466ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:09:03.500881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.336788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-8xfd2-tls\" ","response":"range_response_count:1 size:1967"} {"level":"info","ts":"2026-04-09T06:09:03.500938Z","caller":"traceutil/trace.go:171","msg":"trace[573508325] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-8xfd2-tls; range_end:; response_count:1; response_revision:4837; }","duration":"158.41267ms","start":"2026-04-09T06:09:03.342507Z","end":"2026-04-09T06:09:03.50092Z","steps":["trace[573508325] 'agreement among raft nodes before linearized reading' (duration: 158.302037ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:09:03.501186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.187909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:50 size:2196043"} {"level":"info","ts":"2026-04-09T06:09:03.501273Z","caller":"traceutil/trace.go:171","msg":"trace[1855436341] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:50; response_revision:4837; }","duration":"123.305352ms","start":"2026-04-09T06:09:03.377951Z","end":"2026-04-09T06:09:03.501256Z","steps":["trace[1855436341] 'agreement among raft nodes before linearized reading' (duration: 122.397289ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:09:07.197382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.361039ms","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-04-09T06:09:07.197461Z","caller":"traceutil/trace.go:171","msg":"trace[1335312301] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4970; }","duration":"260.492312ms","start":"2026-04-09T06:09:06.936952Z","end":"2026-04-09T06:09:07.197445Z","steps":["trace[1335312301] 'range keys from in-memory index tree' (duration: 260.178976ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:09:07.313688Z","caller":"traceutil/trace.go:171","msg":"trace[1489247837] transaction","detail":"{read_only:false; response_revision:4973; number_of_response:1; }","duration":"101.123631ms","start":"2026-04-09T06:09:07.212518Z","end":"2026-04-09T06:09:07.313641Z","steps":["trace[1489247837] 'process raft request' (duration: 97.513032ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:09:09.506292Z","caller":"traceutil/trace.go:171","msg":"trace[491418907] linearizableReadLoop","detail":"{readStateIndex:5197; appliedIndex:5196; }","duration":"202.071309ms","start":"2026-04-09T06:09:09.304175Z","end":"2026-04-09T06:09:09.506246Z","steps":["trace[491418907] 'read index received' (duration: 120.487947ms)","trace[491418907] 'applied index is now lower than readState.Index' (duration: 81.582322ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:09:09.5064Z","caller":"traceutil/trace.go:171","msg":"trace[506504789] transaction","detail":"{read_only:false; response_revision:5010; number_of_response:1; }","duration":"235.306127ms","start":"2026-04-09T06:09:09.271062Z","end":"2026-04-09T06:09:09.506368Z","steps":["trace[506504789] 'process raft request' (duration: 153.682594ms)","trace[506504789] 'compare' (duration: 81.367586ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:09:09.506549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.300618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:09:09.506618Z","caller":"traceutil/trace.go:171","msg":"trace[2017333526] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5010; }","duration":"182.405671ms","start":"2026-04-09T06:09:09.324201Z","end":"2026-04-09T06:09:09.506607Z","steps":["trace[2017333526] 'agreement among raft nodes before linearized reading' (duration: 182.198206ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:09:09.506841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.666564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:777469"} {"level":"info","ts":"2026-04-09T06:09:09.506886Z","caller":"traceutil/trace.go:171","msg":"trace[2070224987] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5010; }","duration":"202.755827ms","start":"2026-04-09T06:09:09.304118Z","end":"2026-04-09T06:09:09.506874Z","steps":["trace[2070224987] 'agreement among raft nodes before linearized reading' (duration: 202.249774ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:09:09.507099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.772148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-zp9p7\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-09T06:09:09.507233Z","caller":"traceutil/trace.go:171","msg":"trace[1225733493] range","detail":"{range_begin:/registry/pods/openstack/keepalived-zp9p7; range_end:; response_count:1; response_revision:5010; }","duration":"172.935681ms","start":"2026-04-09T06:09:09.334282Z","end":"2026-04-09T06:09:09.507218Z","steps":["trace[1225733493] 'agreement among raft nodes before linearized reading' (duration: 172.641454ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:09:18.441829Z","caller":"traceutil/trace.go:171","msg":"trace[613670898] linearizableReadLoop","detail":"{readStateIndex:5396; appliedIndex:5395; }","duration":"119.408911ms","start":"2026-04-09T06:09:18.322398Z","end":"2026-04-09T06:09:18.441807Z","steps":["trace[613670898] 'read index received' (duration: 26.379271ms)","trace[613670898] 'applied index is now lower than readState.Index' (duration: 93.02858ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:09:18.441964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.534264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:09:18.442001Z","caller":"traceutil/trace.go:171","msg":"trace[489140862] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5204; }","duration":"119.626176ms","start":"2026-04-09T06:09:18.322367Z","end":"2026-04-09T06:09:18.441994Z","steps":["trace[489140862] 'agreement among raft nodes before linearized reading' (duration: 119.519623ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:09:18.442153Z","caller":"traceutil/trace.go:171","msg":"trace[771039490] transaction","detail":"{read_only:false; response_revision:5204; number_of_response:1; }","duration":"155.752683ms","start":"2026-04-09T06:09:18.286391Z","end":"2026-04-09T06:09:18.442143Z","steps":["trace[771039490] 'process raft request' (duration: 62.450747ms)","trace[771039490] 'compare' (duration: 92.811384ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:09:20.495012Z","caller":"traceutil/trace.go:171","msg":"trace[1385475618] linearizableReadLoop","detail":"{readStateIndex:5430; appliedIndex:5429; }","duration":"172.47797ms","start":"2026-04-09T06:09:20.322508Z","end":"2026-04-09T06:09:20.494986Z","steps":["trace[1385475618] 'read index received' (duration: 172.330596ms)","trace[1385475618] 'applied index is now lower than readState.Index' (duration: 146.434µs)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:09:20.49514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.613754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:09:20.495181Z","caller":"traceutil/trace.go:171","msg":"trace[719675766] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5237; }","duration":"172.695825ms","start":"2026-04-09T06:09:20.322473Z","end":"2026-04-09T06:09:20.495169Z","steps":["trace[719675766] 'agreement among raft nodes before linearized reading' (duration: 172.611483ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:09:20.495116Z","caller":"traceutil/trace.go:171","msg":"trace[1499322709] transaction","detail":"{read_only:false; response_revision:5237; number_of_response:1; }","duration":"178.522717ms","start":"2026-04-09T06:09:20.316521Z","end":"2026-04-09T06:09:20.495044Z","steps":["trace[1499322709] 'process raft request' (duration: 178.287712ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:09:26.549412Z","caller":"traceutil/trace.go:171","msg":"trace[18000454] transaction","detail":"{read_only:false; response_revision:5371; number_of_response:1; }","duration":"190.344635ms","start":"2026-04-09T06:09:26.359041Z","end":"2026-04-09T06:09:26.549385Z","steps":["trace[18000454] 'process raft request' (duration: 190.15864ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:09:26.95983Z","caller":"traceutil/trace.go:171","msg":"trace[279182380] transaction","detail":"{read_only:false; response_revision:5373; number_of_response:1; }","duration":"311.651462ms","start":"2026-04-09T06:09:26.648147Z","end":"2026-04-09T06:09:26.959799Z","steps":["trace[279182380] 'process raft request' (duration: 311.58379ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:09:26.959857Z","caller":"traceutil/trace.go:171","msg":"trace[2080356035] transaction","detail":"{read_only:false; response_revision:5372; number_of_response:1; }","duration":"319.530873ms","start":"2026-04-09T06:09:26.640294Z","end":"2026-04-09T06:09:26.959825Z","steps":["trace[2080356035] 'process raft request' (duration: 301.461623ms)","trace[2080356035] 'compare' (duration: 17.520905ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:09:26.959986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:09:26.648124Z","time spent":"311.787156ms","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-09T06:09:26.960015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:09:26.640277Z","time spent":"319.654736ms","remote":"127.0.0.1:40212","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-04-09T06:09:32.596897Z","caller":"traceutil/trace.go:171","msg":"trace[247058468] transaction","detail":"{read_only:false; response_revision:5477; number_of_response:1; }","duration":"140.553464ms","start":"2026-04-09T06:09:32.45629Z","end":"2026-04-09T06:09:32.596843Z","steps":["trace[247058468] 'process raft request' (duration: 140.316328ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:11:00.915674Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3043} {"level":"info","ts":"2026-04-09T06:11:01.009199Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3043,"took":"91.066508ms","hash":64055975,"current-db-size-bytes":58494976,"current-db-size":"58 MB","current-db-size-in-use-bytes":31858688,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-09T06:11:01.009275Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":64055975,"revision":3043,"compact-revision":-1} {"level":"info","ts":"2026-04-09T06:11:38.387249Z","caller":"traceutil/trace.go:171","msg":"trace[1294576855] transaction","detail":"{read_only:false; response_revision:6426; number_of_response:1; }","duration":"272.351632ms","start":"2026-04-09T06:11:38.11487Z","end":"2026-04-09T06:11:38.387222Z","steps":["trace[1294576855] 'process raft request' (duration: 272.208529ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:11:38.390501Z","caller":"traceutil/trace.go:171","msg":"trace[2017496157] transaction","detail":"{read_only:false; response_revision:6427; number_of_response:1; }","duration":"265.265142ms","start":"2026-04-09T06:11:38.125218Z","end":"2026-04-09T06:11:38.390483Z","steps":["trace[2017496157] 'process raft request' (duration: 265.16164ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:11:38.390847Z","caller":"traceutil/trace.go:171","msg":"trace[1442625630] linearizableReadLoop","detail":"{readStateIndex:6654; appliedIndex:6652; }","duration":"202.605297ms","start":"2026-04-09T06:11:38.188229Z","end":"2026-04-09T06:11:38.390834Z","steps":["trace[1442625630] 'read index received' (duration: 198.882897ms)","trace[1442625630] 'applied index is now lower than readState.Index' (duration: 3.72165ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:11:38.391204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.963105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:11:38.391262Z","caller":"traceutil/trace.go:171","msg":"trace[1303607825] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:6429; }","duration":"203.079357ms","start":"2026-04-09T06:11:38.188168Z","end":"2026-04-09T06:11:38.391248Z","steps":["trace[1303607825] 'agreement among raft nodes before linearized reading' (duration: 202.991275ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:11:40.901977Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2281246319188369260,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-09T06:11:41.403059Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2281246319188369260,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-09T06:11:41.7468Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.354359371s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-09T06:11:43.325588Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.578558447s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-09T06:11:43.387143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.063042855s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:11:43.38724Z","caller":"traceutil/trace.go:171","msg":"trace[2042806808] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6435; }","duration":"3.063210719s","start":"2026-04-09T06:11:40.324007Z","end":"2026-04-09T06:11:43.387218Z","steps":["trace[2042806808] 'range keys from in-memory index tree' (duration: 3.062942003s)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:11:43.387279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:11:40.323976Z","time spent":"3.063294181s","remote":"127.0.0.1:39918","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-04-09T06:11:43.388392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.641281564s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-09T06:11:43.388944Z","caller":"traceutil/trace.go:171","msg":"trace[333576857] linearizableReadLoop","detail":"{readStateIndex:6667; appliedIndex:6663; }","duration":"2.987627792s","start":"2026-04-09T06:11:40.401294Z","end":"2026-04-09T06:11:43.388922Z","steps":["trace[333576857] 'read index received' (duration: 1.345726314s)","trace[333576857] 'applied index is now lower than readState.Index' (duration: 1.641900298s)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:11:43.388967Z","caller":"traceutil/trace.go:171","msg":"trace[972843559] transaction","detail":"{read_only:false; response_revision:6436; number_of_response:1; }","duration":"2.996594188s","start":"2026-04-09T06:11:40.39233Z","end":"2026-04-09T06:11:43.388925Z","steps":["trace[972843559] 'process raft request' (duration: 1.354676599s)","trace[972843559] 'compare' (duration: 1.639539273s)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:11:43.388967Z","caller":"traceutil/trace.go:171","msg":"trace[1814600502] transaction","detail":"{read_only:false; response_revision:6438; number_of_response:1; }","duration":"2.992221244s","start":"2026-04-09T06:11:40.396713Z","end":"2026-04-09T06:11:43.388934Z","steps":["trace[1814600502] 'process raft request' (duration: 2.99209222s)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:11:43.388986Z","caller":"traceutil/trace.go:171","msg":"trace[383402921] transaction","detail":"{read_only:false; response_revision:6437; number_of_response:1; }","duration":"2.99419549s","start":"2026-04-09T06:11:40.39475Z","end":"2026-04-09T06:11:43.388946Z","steps":["trace[383402921] 'process raft request' (duration: 2.993960544s)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:11:43.388966Z","caller":"traceutil/trace.go:171","msg":"trace[1219423854] transaction","detail":"{read_only:false; response_revision:6439; number_of_response:1; }","duration":"2.991708331s","start":"2026-04-09T06:11:40.397224Z","end":"2026-04-09T06:11:43.388933Z","steps":["trace[1219423854] 'process raft request' (duration: 2.99163917s)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:11:43.389125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:11:40.396658Z","time spent":"2.992380707s","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-09T06:11:43.389132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:11:40.394737Z","time spent":"2.994326984s","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-09T06:11:43.389149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.897312243s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-09T06:11:43.389126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:11:40.392311Z","time spent":"2.996724011s","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-09T06:11:43.389243Z","caller":"traceutil/trace.go:171","msg":"trace[640919092] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:6439; }","duration":"1.897443736s","start":"2026-04-09T06:11:41.491781Z","end":"2026-04-09T06:11:43.389225Z","steps":["trace[640919092] 'agreement among raft nodes before linearized reading' (duration: 1.897283673s)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:11:43.389164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"634.337837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-09T06:11:43.389268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.987048009s","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-04-09T06:11:43.389305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:11:41.491762Z","time spent":"1.897526409s","remote":"127.0.0.1:40280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":40,"response size":30,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"warn","ts":"2026-04-09T06:11:43.38933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.701548631s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-09T06:11:43.38938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.556265393s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-04-09T06:11:43.389378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.956817584s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-09T06:11:43.38942Z","caller":"traceutil/trace.go:171","msg":"trace[1154247681] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6439; }","duration":"2.556306564s","start":"2026-04-09T06:11:40.833103Z","end":"2026-04-09T06:11:43.38941Z","steps":["trace[1154247681] 'agreement among raft nodes before linearized reading' (duration: 2.556116218s)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:11:43.389353Z","caller":"traceutil/trace.go:171","msg":"trace[998518319] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6439; }","duration":"634.553421ms","start":"2026-04-09T06:11:42.754734Z","end":"2026-04-09T06:11:43.389288Z","steps":["trace[998518319] 'agreement among raft nodes before linearized reading' (duration: 634.332566ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:11:43.389422Z","caller":"traceutil/trace.go:171","msg":"trace[194049630] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6439; }","duration":"1.701691316s","start":"2026-04-09T06:11:41.687706Z","end":"2026-04-09T06:11:43.389398Z","steps":["trace[194049630] 'agreement among raft nodes before linearized reading' (duration: 1.701376577s)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:11:43.389427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.08737371s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:11:43.389437Z","caller":"traceutil/trace.go:171","msg":"trace[1911428113] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6439; }","duration":"2.956919586s","start":"2026-04-09T06:11:40.4325Z","end":"2026-04-09T06:11:43.38942Z","steps":["trace[1911428113] 'agreement among raft nodes before linearized reading' (duration: 2.956747261s)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:11:43.389449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:11:40.833043Z","time spent":"2.556401056s","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-09T06:11:43.38945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.63617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:528"} {"level":"info","ts":"2026-04-09T06:11:43.38947Z","caller":"traceutil/trace.go:171","msg":"trace[651586562] range","detail":"{range_begin:/registry/secretgen.k14s.io/rsakeys/; range_end:/registry/secretgen.k14s.io/rsakeys0; response_count:0; response_revision:6439; }","duration":"2.087458032s","start":"2026-04-09T06:11:41.302Z","end":"2026-04-09T06:11:43.389458Z","steps":["trace[651586562] 'agreement among raft nodes before linearized reading' (duration: 2.08739352s)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:11:43.389451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.676241864s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/thanosrulers/\" range_end:\"/registry/monitoring.coreos.com/thanosrulers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-09T06:11:43.389476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:11:40.432479Z","time spent":"2.956987958s","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-09T06:11:43.389477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.061832796s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/keystone-api\" ","response":"range_response_count:1 size:674"} {"level":"warn","ts":"2026-04-09T06:11:43.389516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:11:41.301976Z","time spent":"2.087531454s","remote":"127.0.0.1:57640","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true "} {"level":"info","ts":"2026-04-09T06:11:43.389524Z","caller":"traceutil/trace.go:171","msg":"trace[852096602] range","detail":"{range_begin:/registry/monitoring.coreos.com/thanosrulers/; range_end:/registry/monitoring.coreos.com/thanosrulers0; response_count:0; response_revision:6439; }","duration":"2.676363837s","start":"2026-04-09T06:11:40.713142Z","end":"2026-04-09T06:11:43.389506Z","steps":["trace[852096602] 'agreement among raft nodes before linearized reading' (duration: 2.676240924s)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:11:43.389469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:11:41.687685Z","time spent":"1.701774827s","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-09T06:11:43.389482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:11:42.754718Z","time spent":"634.739877ms","remote":"127.0.0.1:39926","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-04-09T06:11:43.389546Z","caller":"traceutil/trace.go:171","msg":"trace[1540465921] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:6439; }","duration":"133.800404ms","start":"2026-04-09T06:11:43.255699Z","end":"2026-04-09T06:11:43.389499Z","steps":["trace[1540465921] 'agreement among raft nodes before linearized reading' (duration: 133.402993ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:11:43.389568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:11:40.713125Z","time spent":"2.676432649s","remote":"127.0.0.1:39364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/monitoring.coreos.com/thanosrulers/\" range_end:\"/registry/monitoring.coreos.com/thanosrulers0\" count_only:true "} {"level":"info","ts":"2026-04-09T06:11:43.389352Z","caller":"traceutil/trace.go:171","msg":"trace[1164915482] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6439; }","duration":"2.987151382s","start":"2026-04-09T06:11:40.402178Z","end":"2026-04-09T06:11:43.389329Z","steps":["trace[1164915482] 'agreement among raft nodes before linearized reading' (duration: 2.986890235s)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:11:43.389694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:11:40.40217Z","time spent":"2.987515921s","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-09T06:11:43.38953Z","caller":"traceutil/trace.go:171","msg":"trace[1922442044] range","detail":"{range_begin:/registry/services/endpoints/openstack/keystone-api; range_end:; response_count:1; response_revision:6439; }","duration":"2.061922097s","start":"2026-04-09T06:11:41.327595Z","end":"2026-04-09T06:11:43.389518Z","steps":["trace[1922442044] 'agreement among raft nodes before linearized reading' (duration: 2.061739183s)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:11:43.389457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.986759393s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-zp9p7\" ","response":"range_response_count:1 size:6524"} {"level":"warn","ts":"2026-04-09T06:11:43.389775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:11:41.327575Z","time spent":"2.062157893s","remote":"127.0.0.1:40092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":697,"request content":"key:\"/registry/services/endpoints/openstack/keystone-api\" "} {"level":"info","ts":"2026-04-09T06:11:43.389832Z","caller":"traceutil/trace.go:171","msg":"trace[474597157] range","detail":"{range_begin:/registry/pods/openstack/keepalived-zp9p7; range_end:; response_count:1; response_revision:6439; }","duration":"2.987151683s","start":"2026-04-09T06:11:40.402673Z","end":"2026-04-09T06:11:43.389825Z","steps":["trace[474597157] 'agreement among raft nodes before linearized reading' (duration: 2.986643141s)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:11:43.389855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:11:40.402667Z","time spent":"2.987181433s","remote":"127.0.0.1:40116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6547,"request content":"key:\"/registry/pods/openstack/keepalived-zp9p7\" "} {"level":"warn","ts":"2026-04-09T06:11:43.389381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:11:40.397211Z","time spent":"2.991918626s","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-09T06:11:43.391513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.990171114s","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-04-09T06:11:43.391643Z","caller":"traceutil/trace.go:171","msg":"trace[153561109] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6439; }","duration":"2.990355358s","start":"2026-04-09T06:11:40.40126Z","end":"2026-04-09T06:11:43.391615Z","steps":["trace[153561109] 'agreement among raft nodes before linearized reading' (duration: 2.987757175s)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:11:43.39173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:11:40.401251Z","time spent":"2.99046906s","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-09T06:11:43.585292Z","caller":"traceutil/trace.go:171","msg":"trace[1345354498] transaction","detail":"{read_only:false; response_revision:6441; number_of_response:1; }","duration":"190.531277ms","start":"2026-04-09T06:11:43.394725Z","end":"2026-04-09T06:11:43.585256Z","steps":["trace[1345354498] 'process raft request' (duration: 190.455985ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:11:43.585419Z","caller":"traceutil/trace.go:171","msg":"trace[784927522] transaction","detail":"{read_only:false; response_revision:6440; number_of_response:1; }","duration":"190.889395ms","start":"2026-04-09T06:11:43.3945Z","end":"2026-04-09T06:11:43.585389Z","steps":["trace[784927522] 'process raft request' (duration: 135.350982ms)","trace[784927522] 'compare' (duration: 55.165005ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:11:43.58567Z","caller":"traceutil/trace.go:171","msg":"trace[13620317] transaction","detail":"{read_only:false; response_revision:6442; number_of_response:1; }","duration":"191.03041ms","start":"2026-04-09T06:11:43.394626Z","end":"2026-04-09T06:11:43.585656Z","steps":["trace[13620317] 'process raft request' (duration: 190.608089ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:11:43.585795Z","caller":"traceutil/trace.go:171","msg":"trace[1368771877] transaction","detail":"{read_only:false; response_revision:6444; number_of_response:1; }","duration":"189.983204ms","start":"2026-04-09T06:11:43.3958Z","end":"2026-04-09T06:11:43.585783Z","steps":["trace[1368771877] 'process raft request' (duration: 189.874181ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:11:43.585824Z","caller":"traceutil/trace.go:171","msg":"trace[1435137965] transaction","detail":"{read_only:false; response_revision:6443; number_of_response:1; }","duration":"190.695291ms","start":"2026-04-09T06:11:43.395122Z","end":"2026-04-09T06:11:43.585817Z","steps":["trace[1435137965] 'process raft request' (duration: 190.392613ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:11:43.585825Z","caller":"traceutil/trace.go:171","msg":"trace[930736150] transaction","detail":"{read_only:false; response_revision:6445; number_of_response:1; }","duration":"189.665796ms","start":"2026-04-09T06:11:43.396135Z","end":"2026-04-09T06:11:43.585801Z","steps":["trace[930736150] 'process raft request' (duration: 189.587314ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:11:43.586357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.737341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:16 size:142135"} {"level":"info","ts":"2026-04-09T06:11:43.586427Z","caller":"traceutil/trace.go:171","msg":"trace[468087159] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:16; response_revision:6445; }","duration":"190.855485ms","start":"2026-04-09T06:11:43.39556Z","end":"2026-04-09T06:11:43.586415Z","steps":["trace[468087159] 'agreement among raft nodes before linearized reading' (duration: 190.330162ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:11:43.585819Z","caller":"traceutil/trace.go:171","msg":"trace[546075701] linearizableReadLoop","detail":"{readStateIndex:6672; appliedIndex:6667; }","duration":"190.204649ms","start":"2026-04-09T06:11:43.395582Z","end":"2026-04-09T06:11:43.585786Z","steps":["trace[546075701] 'read index received' (duration: 134.271975ms)","trace[546075701] 'applied index is now lower than readState.Index' (duration: 55.930944ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:11:43.586564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.078703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:11:43.586622Z","caller":"traceutil/trace.go:171","msg":"trace[536980467] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6445; }","duration":"189.163844ms","start":"2026-04-09T06:11:43.397444Z","end":"2026-04-09T06:11:43.586608Z","steps":["trace[536980467] 'agreement among raft nodes before linearized reading' (duration: 189.062312ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:11:43.586843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.924477ms","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-04-09T06:11:43.586884Z","caller":"traceutil/trace.go:171","msg":"trace[194693345] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:6445; }","duration":"113.995459ms","start":"2026-04-09T06:11:43.472879Z","end":"2026-04-09T06:11:43.586874Z","steps":["trace[194693345] 'agreement among raft nodes before linearized reading' (duration: 113.897806ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:11:44.413782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.536126ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-09T06:11:44.41407Z","caller":"traceutil/trace.go:171","msg":"trace[1051090449] transaction","detail":"{read_only:false; response_revision:6446; number_of_response:1; }","duration":"827.293081ms","start":"2026-04-09T06:11:43.586741Z","end":"2026-04-09T06:11:44.414034Z","steps":["trace[1051090449] 'process raft request' (duration: 554.396457ms)","trace[1051090449] 'compare' (duration: 272.243609ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:11:44.414144Z","caller":"traceutil/trace.go:171","msg":"trace[1512801067] linearizableReadLoop","detail":"{readStateIndex:6676; appliedIndex:6674; }","duration":"551.075187ms","start":"2026-04-09T06:11:43.863047Z","end":"2026-04-09T06:11:44.414122Z","steps":["trace[1512801067] 'read index received' (duration: 278.11198ms)","trace[1512801067] 'applied index is now lower than readState.Index' (duration: 272.961527ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:11:44.414228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:11:43.586715Z","time spent":"827.436004ms","remote":"127.0.0.1:40016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-09T06:11:44.414504Z","caller":"traceutil/trace.go:171","msg":"trace[1716790771] transaction","detail":"{read_only:false; response_revision:6447; number_of_response:1; }","duration":"823.09505ms","start":"2026-04-09T06:11:43.591392Z","end":"2026-04-09T06:11:44.414487Z","steps":["trace[1716790771] 'process raft request' (duration: 822.597148ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:11:44.414619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:11:43.591376Z","time spent":"823.182682ms","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-09T06:11:44.41475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.279105ms","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-04-09T06:11:44.414801Z","caller":"traceutil/trace.go:171","msg":"trace[1167664300] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6447; }","duration":"549.402437ms","start":"2026-04-09T06:11:43.865387Z","end":"2026-04-09T06:11:44.414789Z","steps":["trace[1167664300] 'agreement among raft nodes before linearized reading' (duration: 549.225213ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:11:44.414836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:11:43.865358Z","time spent":"549.469019ms","remote":"127.0.0.1:40116","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":"warn","ts":"2026-04-09T06:11:44.415039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.993869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:11:44.415085Z","caller":"traceutil/trace.go:171","msg":"trace[1635282206] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:6447; }","duration":"552.078151ms","start":"2026-04-09T06:11:43.862995Z","end":"2026-04-09T06:11:44.415073Z","steps":["trace[1635282206] 'agreement among raft nodes before linearized reading' (duration: 552.01081ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:11:44.415119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:11:43.862978Z","time spent":"552.131682ms","remote":"127.0.0.1:37288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-04-09T06:11:44.415922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.21723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1986"} {"level":"info","ts":"2026-04-09T06:11:44.415986Z","caller":"traceutil/trace.go:171","msg":"trace[1686589062] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:6447; }","duration":"123.315882ms","start":"2026-04-09T06:11:44.292653Z","end":"2026-04-09T06:11:44.415969Z","steps":["trace[1686589062] 'agreement among raft nodes before linearized reading' (duration: 122.36099ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:11:44.416186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.448798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.118\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-09T06:11:44.416294Z","caller":"traceutil/trace.go:171","msg":"trace[269017405] range","detail":"{range_begin:/registry/masterleases/199.19.213.118; range_end:; response_count:1; response_revision:6447; }","duration":"549.566151ms","start":"2026-04-09T06:11:43.866709Z","end":"2026-04-09T06:11:44.416275Z","steps":["trace[269017405] 'agreement among raft nodes before linearized reading' (duration: 548.769152ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:11:44.41639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:11:43.866643Z","time spent":"549.734834ms","remote":"127.0.0.1:39954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.118\" "} {"level":"warn","ts":"2026-04-09T06:12:18.22019Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2281246319188369756,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-09T06:12:18.721028Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2281246319188369756,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-09T06:12:19.221806Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2281246319188369756,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-09T06:12:19.723025Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2281246319188369756,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-09T06:12:20.224126Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2281246319188369756,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-09T06:12:20.324079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000184154s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-09T06:12:20.324214Z","caller":"traceutil/trace.go:171","msg":"trace[1468510969] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.001148877s","start":"2026-04-09T06:12:18.323042Z","end":"2026-04-09T06:12:20.324191Z","steps":["trace[1468510969] 'agreement among raft nodes before linearized reading' (duration: 2.000202225s)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:12:20.324531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:12:18.323031Z","time spent":"2.001475145s","remote":"127.0.0.1:39926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/09 06:12:20 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-09T06:12:20.725309Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2281246319188369756,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-09T06:12:21.225971Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2281246319188369756,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-09T06:12:21.408999Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.856380688s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-09T06:12:21.490631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.16772553s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-09T06:12:21.490926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.763496381s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:12:21.490704Z","caller":"traceutil/trace.go:171","msg":"trace[162276119] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6620; }","duration":"5.167845723s","start":"2026-04-09T06:12:16.322841Z","end":"2026-04-09T06:12:21.490687Z","steps":["trace[162276119] 'range keys from in-memory index tree' (duration: 5.167655208s)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:12:21.491087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:12:16.322816Z","time spent":"5.168260233s","remote":"127.0.0.1:39918","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-04-09T06:12:21.491009Z","caller":"traceutil/trace.go:171","msg":"trace[1320222906] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:6620; }","duration":"2.763583874s","start":"2026-04-09T06:12:18.727414Z","end":"2026-04-09T06:12:21.490998Z","steps":["trace[1320222906] 'range keys from in-memory index tree' (duration: 2.763486131s)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:12:21.491588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.699982956s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:12:21.491636Z","caller":"traceutil/trace.go:171","msg":"trace[65186262] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:6620; }","duration":"4.700071258s","start":"2026-04-09T06:12:16.791548Z","end":"2026-04-09T06:12:21.491619Z","steps":["trace[65186262] 'count revisions from in-memory index tree' (duration: 4.699869933s)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:12:21.49164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.836156978s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:12:21.491762Z","caller":"traceutil/trace.go:171","msg":"trace[643243217] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:6620; }","duration":"4.836353602s","start":"2026-04-09T06:12:16.655382Z","end":"2026-04-09T06:12:21.491735Z","steps":["trace[643243217] 'count revisions from in-memory index tree' (duration: 4.836054795s)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:12:21.491827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:12:16.655358Z","time spent":"4.836453665s","remote":"127.0.0.1:33064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-09T06:12:21.49232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.999833839s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-09T06:12:21.491702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:12:16.791523Z","time spent":"4.700136189s","remote":"127.0.0.1:37254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "} {"level":"info","ts":"2026-04-09T06:12:21.492366Z","caller":"traceutil/trace.go:171","msg":"trace[2074538471] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:6620; }","duration":"3.999936171s","start":"2026-04-09T06:12:17.49242Z","end":"2026-04-09T06:12:21.492357Z","steps":["trace[2074538471] 'count revisions from in-memory index tree' (duration: 3.999661125s)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:12:21.492741Z","caller":"traceutil/trace.go:171","msg":"trace[708848065] transaction","detail":"{read_only:false; response_revision:6621; number_of_response:1; }","duration":"3.940204266s","start":"2026-04-09T06:12:17.552481Z","end":"2026-04-09T06:12:21.492685Z","steps":["trace[708848065] 'process raft request' (duration: 3.856828198s)","trace[708848065] 'compare' (duration: 80.9924ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:12:21.495002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:12:17.552457Z","time spent":"3.942449s","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-09T06:12:21.496098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:12:17.492391Z","time spent":"4.002371521s","remote":"127.0.0.1:40364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"info","ts":"2026-04-09T06:12:21.558838Z","caller":"traceutil/trace.go:171","msg":"trace[59657708] transaction","detail":"{read_only:false; response_revision:6622; number_of_response:1; }","duration":"3.990885594s","start":"2026-04-09T06:12:17.567917Z","end":"2026-04-09T06:12:21.558802Z","steps":["trace[59657708] 'process raft request' (duration: 3.990160817s)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:12:21.55903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:12:17.567884Z","time spent":"3.991041927s","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-09T06:12:21.559307Z","caller":"traceutil/trace.go:171","msg":"trace[229401493] transaction","detail":"{read_only:false; response_revision:6623; number_of_response:1; }","duration":"3.990051053s","start":"2026-04-09T06:12:17.569244Z","end":"2026-04-09T06:12:21.559295Z","steps":["trace[229401493] 'process raft request' (duration: 3.989125891s)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:12:21.559369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:12:17.569232Z","time spent":"3.990106524s","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-09T06:12:21.559517Z","caller":"traceutil/trace.go:171","msg":"trace[1258068687] transaction","detail":"{read_only:false; response_revision:6624; number_of_response:1; }","duration":"3.988472566s","start":"2026-04-09T06:12:17.571031Z","end":"2026-04-09T06:12:21.559504Z","steps":["trace[1258068687] 'process raft request' (duration: 3.98738987s)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:12:21.559575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:12:17.571003Z","time spent":"3.988541648s","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-09T06:12:21.628623Z","caller":"traceutil/trace.go:171","msg":"trace[838758830] linearizableReadLoop","detail":"{readStateIndex:6862; appliedIndex:6856; }","duration":"3.908623119s","start":"2026-04-09T06:12:17.719963Z","end":"2026-04-09T06:12:21.628586Z","steps":["trace[838758830] 'read index received' (duration: 3.689341366s)","trace[838758830] 'applied index is now lower than readState.Index' (duration: 219.280013ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:12:21.628941Z","caller":"traceutil/trace.go:171","msg":"trace[832915972] transaction","detail":"{read_only:false; response_revision:6625; number_of_response:1; }","duration":"1.223481061s","start":"2026-04-09T06:12:20.405412Z","end":"2026-04-09T06:12:21.628893Z","steps":["trace[832915972] 'process raft request' (duration: 1.222942578s)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:12:21.629151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:12:20.405378Z","time spent":"1.223666876s","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-09T06:12:21.718459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.998447723s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-09T06:12:21.718488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.592196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keystone-domain-manage-jhjth\" ","response":"range_response_count:1 size:8154"} {"level":"info","ts":"2026-04-09T06:12:21.718563Z","caller":"traceutil/trace.go:171","msg":"trace[1217129076] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:6625; }","duration":"3.998618097s","start":"2026-04-09T06:12:17.719912Z","end":"2026-04-09T06:12:21.71853Z","steps":["trace[1217129076] 'agreement among raft nodes before linearized reading' (duration: 3.908905405s)","trace[1217129076] 'count revisions from in-memory index tree' (duration: 89.521437ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:12:21.71862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:12:17.719898Z","time spent":"3.998708949s","remote":"127.0.0.1:39348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":6,"response size":30,"request content":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true "} {"level":"warn","ts":"2026-04-09T06:12:21.718643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.903770338s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-04-09T06:12:21.718639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.88604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-09T06:12:21.718716Z","caller":"traceutil/trace.go:171","msg":"trace[1188205842] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6625; }","duration":"3.90384091s","start":"2026-04-09T06:12:17.814854Z","end":"2026-04-09T06:12:21.718695Z","steps":["trace[1188205842] 'agreement among raft nodes before linearized reading' (duration: 3.814156639s)","trace[1188205842] 'range keys from in-memory index tree' (duration: 89.523588ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:12:21.718729Z","caller":"traceutil/trace.go:171","msg":"trace[152381823] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:6625; }","duration":"230.024073ms","start":"2026-04-09T06:12:21.488681Z","end":"2026-04-09T06:12:21.718706Z","steps":["trace[152381823] 'agreement among raft nodes before linearized reading' (duration: 140.286751ms)","trace[152381823] 'count revisions from in-memory index tree' (duration: 89.610909ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:12:21.718777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:12:17.81485Z","time spent":"3.903914081s","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-09T06:12:21.718779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.931534445s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-09T06:12:21.718618Z","caller":"traceutil/trace.go:171","msg":"trace[985907693] range","detail":"{range_begin:/registry/pods/openstack/keystone-domain-manage-jhjth; range_end:; response_count:1; response_revision:6625; }","duration":"179.718929ms","start":"2026-04-09T06:12:21.538832Z","end":"2026-04-09T06:12:21.718551Z","steps":["trace[985907693] 'agreement among raft nodes before linearized reading' (duration: 90.123741ms)","trace[985907693] 'range keys from in-memory index tree' (duration: 89.384103ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:12:21.718873Z","caller":"traceutil/trace.go:171","msg":"trace[94373907] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6625; }","duration":"3.931637587s","start":"2026-04-09T06:12:17.78721Z","end":"2026-04-09T06:12:21.718847Z","steps":["trace[94373907] 'agreement among raft nodes before linearized reading' (duration: 3.841796173s)","trace[94373907] 'range keys from in-memory index tree' (duration: 89.601179ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:12:21.718918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:12:17.787189Z","time spent":"3.93171944s","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-09T06:12:21.71848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.284245137s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-09T06:12:21.719046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.388120633s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:12:21.719076Z","caller":"traceutil/trace.go:171","msg":"trace[78679231] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6625; }","duration":"1.388185765s","start":"2026-04-09T06:12:20.330879Z","end":"2026-04-09T06:12:21.719065Z","steps":["trace[78679231] 'agreement among raft nodes before linearized reading' (duration: 1.298112734s)","trace[78679231] 'range keys from in-memory index tree' (duration: 90.035839ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:12:21.719095Z","caller":"traceutil/trace.go:171","msg":"trace[1425242465] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:6625; }","duration":"1.284908594s","start":"2026-04-09T06:12:20.434153Z","end":"2026-04-09T06:12:21.719062Z","steps":["trace[1425242465] 'agreement among raft nodes before linearized reading' (duration: 1.194788452s)","trace[1425242465] 'count revisions from in-memory index tree' (duration: 89.450736ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:12:21.719122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:12:20.330862Z","time spent":"1.388253816s","remote":"127.0.0.1:39918","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-04-09T06:12:21.719139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:12:20.434136Z","time spent":"1.284988725s","remote":"127.0.0.1:41718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true "} {"level":"warn","ts":"2026-04-09T06:12:21.719144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.521791583s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-09T06:12:21.719148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.955556572s","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-04-09T06:12:21.719196Z","caller":"traceutil/trace.go:171","msg":"trace[474578764] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:6625; }","duration":"3.521888185s","start":"2026-04-09T06:12:18.197289Z","end":"2026-04-09T06:12:21.719177Z","steps":["trace[474578764] 'agreement among raft nodes before linearized reading' (duration: 3.431730623s)","trace[474578764] 'count revisions from in-memory index tree' (duration: 90.090561ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:12:21.719241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.897409865s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-09T06:12:21.71925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.461417973s","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-04-09T06:12:21.719226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.902972979s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-zp9p7\" ","response":"range_response_count:1 size:6524"} {"level":"warn","ts":"2026-04-09T06:12:21.719257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:12:18.197266Z","time spent":"3.521974567s","remote":"127.0.0.1:40200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":30,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"info","ts":"2026-04-09T06:12:21.719279Z","caller":"traceutil/trace.go:171","msg":"trace[1991162366] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:6625; }","duration":"3.461473195s","start":"2026-04-09T06:12:18.257799Z","end":"2026-04-09T06:12:21.719272Z","steps":["trace[1991162366] 'agreement among raft nodes before linearized reading' (duration: 3.371182159s)","trace[1991162366] 'count revisions from in-memory index tree' (duration: 90.252385ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:12:21.719279Z","caller":"traceutil/trace.go:171","msg":"trace[949251783] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusagents/; range_end:/registry/monitoring.coreos.com/prometheusagents0; response_count:0; response_revision:6625; }","duration":"2.897477197s","start":"2026-04-09T06:12:18.821792Z","end":"2026-04-09T06:12:21.719269Z","steps":["trace[949251783] 'agreement among raft nodes before linearized reading' (duration: 2.807222292s)","trace[949251783] 'count revisions from in-memory index tree' (duration: 90.169643ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:12:21.719302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:12:18.82177Z","time spent":"2.897527308s","remote":"127.0.0.1:39320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true "} {"level":"info","ts":"2026-04-09T06:12:21.719298Z","caller":"traceutil/trace.go:171","msg":"trace[1819767808] range","detail":"{range_begin:/registry/pods/openstack/keepalived-zp9p7; range_end:; response_count:1; response_revision:6625; }","duration":"3.903102542s","start":"2026-04-09T06:12:17.816179Z","end":"2026-04-09T06:12:21.719281Z","steps":["trace[1819767808] 'agreement among raft nodes before linearized reading' (duration: 3.812865108s)","trace[1819767808] 'range keys from in-memory index tree' (duration: 90.08801ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:12:21.719342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.470326977s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"warn","ts":"2026-04-09T06:12:21.719365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:12:17.816161Z","time spent":"3.903193854s","remote":"127.0.0.1:40116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6547,"request content":"key:\"/registry/pods/openstack/keepalived-zp9p7\" "} {"level":"warn","ts":"2026-04-09T06:12:21.719379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.911685618s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-09T06:12:21.719393Z","caller":"traceutil/trace.go:171","msg":"trace[413988998] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6625; }","duration":"1.470423379s","start":"2026-04-09T06:12:20.248951Z","end":"2026-04-09T06:12:21.719375Z","steps":["trace[413988998] 'agreement among raft nodes before linearized reading' (duration: 1.380079962s)","trace[413988998] 'range keys from in-memory index tree' (duration: 90.198853ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:12:21.719414Z","caller":"traceutil/trace.go:171","msg":"trace[1699841135] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6625; }","duration":"3.911726809s","start":"2026-04-09T06:12:17.807674Z","end":"2026-04-09T06:12:21.719401Z","steps":["trace[1699841135] 'agreement among raft nodes before linearized reading' (duration: 3.821322401s)","trace[1699841135] 'range keys from in-memory index tree' (duration: 90.318426ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:12:21.719428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:12:20.248923Z","time spent":"1.470498531s","remote":"127.0.0.1:40116","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":"warn","ts":"2026-04-09T06:12:21.71921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.00918198s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-09T06:12:21.719508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.392385904s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18a49b7a77fa6934\" ","response":"range_response_count:1 size:774"} {"level":"warn","ts":"2026-04-09T06:12:21.719303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:12:18.257783Z","time spent":"3.461513865s","remote":"127.0.0.1:41702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-04-09T06:12:21.719521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.532621653s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-09T06:12:21.71955Z","caller":"traceutil/trace.go:171","msg":"trace[817928766] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18a49b7a77fa6934; range_end:; response_count:1; response_revision:6625; }","duration":"1.392465356s","start":"2026-04-09T06:12:20.327071Z","end":"2026-04-09T06:12:21.719537Z","steps":["trace[817928766] 'agreement among raft nodes before linearized reading' (duration: 1.301932405s)","trace[817928766] 'range keys from in-memory index tree' (duration: 90.456209ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:12:21.719561Z","caller":"traceutil/trace.go:171","msg":"trace[838611238] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:6625; }","duration":"2.532697145s","start":"2026-04-09T06:12:19.186851Z","end":"2026-04-09T06:12:21.719548Z","steps":["trace[838611238] 'agreement among raft nodes before linearized reading' (duration: 2.442167704s)","trace[838611238] 'count revisions from in-memory index tree' (duration: 90.47269ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:12:21.719586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:12:20.327046Z","time spent":"1.392533608s","remote":"127.0.0.1:40016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":797,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.18a49b7a77fa6934\" "} {"level":"warn","ts":"2026-04-09T06:12:21.719592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.910381007s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-09T06:12:21.719594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:12:19.18682Z","time spent":"2.532765716s","remote":"127.0.0.1:40278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":9,"response size":30,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"info","ts":"2026-04-09T06:12:21.719587Z","caller":"traceutil/trace.go:171","msg":"trace[660188868] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:6625; }","duration":"3.009484777s","start":"2026-04-09T06:12:18.709992Z","end":"2026-04-09T06:12:21.719476Z","steps":["trace[660188868] 'agreement among raft nodes before linearized reading' (duration: 2.919065929s)","trace[660188868] 'count revisions from in-memory index tree' (duration: 90.10205ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:12:21.719617Z","caller":"traceutil/trace.go:171","msg":"trace[1727194545] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6625; }","duration":"3.911549265s","start":"2026-04-09T06:12:17.80806Z","end":"2026-04-09T06:12:21.719609Z","steps":["trace[1727194545] 'agreement among raft nodes before linearized reading' (duration: 3.820925751s)","trace[1727194545] 'range keys from in-memory index tree' (duration: 89.336083ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:12:21.719443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:12:17.807669Z","time spent":"3.91176768s","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-09T06:12:21.719651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:12:17.808057Z","time spent":"3.911589876s","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-09T06:12:21.719663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:12:18.709975Z","time spent":"3.009667601s","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":14,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"info","ts":"2026-04-09T06:12:21.719211Z","caller":"traceutil/trace.go:171","msg":"trace[1805541298] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6625; }","duration":"3.955647574s","start":"2026-04-09T06:12:17.763544Z","end":"2026-04-09T06:12:21.719192Z","steps":["trace[1805541298] 'agreement among raft nodes before linearized reading' (duration: 3.86541745s)","trace[1805541298] 'range keys from in-memory index tree' (duration: 89.540718ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:12:21.720101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T06:12:17.763524Z","time spent":"3.956372342s","remote":"127.0.0.1:40212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-09T06:12:21.865082Z","caller":"traceutil/trace.go:171","msg":"trace[135150111] transaction","detail":"{read_only:false; response_revision:6633; number_of_response:1; }","duration":"120.984332ms","start":"2026-04-09T06:12:21.744077Z","end":"2026-04-09T06:12:21.865061Z","steps":["trace[135150111] 'process raft request' (duration: 120.937361ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:12:21.865128Z","caller":"traceutil/trace.go:171","msg":"trace[825177959] transaction","detail":"{read_only:false; response_revision:6630; number_of_response:1; }","duration":"139.312788ms","start":"2026-04-09T06:12:21.72579Z","end":"2026-04-09T06:12:21.865103Z","steps":["trace[825177959] 'process raft request' (duration: 139.105163ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:12:21.865356Z","caller":"traceutil/trace.go:171","msg":"trace[654432378] transaction","detail":"{read_only:false; response_revision:6631; number_of_response:1; }","duration":"139.480242ms","start":"2026-04-09T06:12:21.725864Z","end":"2026-04-09T06:12:21.865344Z","steps":["trace[654432378] 'process raft request' (duration: 139.060781ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:12:21.865501Z","caller":"traceutil/trace.go:171","msg":"trace[2096348474] transaction","detail":"{read_only:false; response_revision:6627; number_of_response:1; }","duration":"141.749766ms","start":"2026-04-09T06:12:21.723736Z","end":"2026-04-09T06:12:21.865486Z","steps":["trace[2096348474] 'process raft request' (duration: 100.355709ms)","trace[2096348474] 'compare' (duration: 40.571847ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:12:21.86566Z","caller":"traceutil/trace.go:171","msg":"trace[1419959169] transaction","detail":"{read_only:false; response_revision:6628; number_of_response:1; }","duration":"140.849865ms","start":"2026-04-09T06:12:21.7248Z","end":"2026-04-09T06:12:21.86565Z","steps":["trace[1419959169] 'process raft request' (duration: 139.983354ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:12:21.865699Z","caller":"traceutil/trace.go:171","msg":"trace[287131575] linearizableReadLoop","detail":"{readStateIndex:6865; appliedIndex:6862; }","duration":"140.131758ms","start":"2026-04-09T06:12:21.725559Z","end":"2026-04-09T06:12:21.865691Z","steps":["trace[287131575] 'read index received' (duration: 16.216465ms)","trace[287131575] 'applied index is now lower than readState.Index' (duration: 123.912013ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:12:21.86579Z","caller":"traceutil/trace.go:171","msg":"trace[733912541] transaction","detail":"{read_only:false; response_revision:6629; number_of_response:1; }","duration":"140.208739ms","start":"2026-04-09T06:12:21.725571Z","end":"2026-04-09T06:12:21.86578Z","steps":["trace[733912541] 'process raft request' (duration: 139.266146ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:12:21.865664Z","caller":"traceutil/trace.go:171","msg":"trace[1961250284] transaction","detail":"{read_only:false; response_revision:6632; number_of_response:1; }","duration":"136.089959ms","start":"2026-04-09T06:12:21.729564Z","end":"2026-04-09T06:12:21.865654Z","steps":["trace[1961250284] 'process raft request' (duration: 135.397382ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:12:21.866085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.504277ms","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-04-09T06:12:21.866128Z","caller":"traceutil/trace.go:171","msg":"trace[234770141] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6633; }","duration":"140.579408ms","start":"2026-04-09T06:12:21.725539Z","end":"2026-04-09T06:12:21.866118Z","steps":["trace[234770141] 'agreement among raft nodes before linearized reading' (duration: 140.429014ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:12:21.866409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.823675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-e6c14b3b-cebe-473a-8c4e-f5f88e0778a6\" ","response":"range_response_count:1 size:1435"} {"level":"info","ts":"2026-04-09T06:12:21.866454Z","caller":"traceutil/trace.go:171","msg":"trace[1791293795] range","detail":"{range_begin:/registry/persistentvolumes/pvc-e6c14b3b-cebe-473a-8c4e-f5f88e0778a6; range_end:; response_count:1; response_revision:6633; }","duration":"140.891287ms","start":"2026-04-09T06:12:21.72555Z","end":"2026-04-09T06:12:21.866441Z","steps":["trace[1791293795] 'agreement among raft nodes before linearized reading' (duration: 140.791034ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:12:21.866728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.181815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:12:21.866765Z","caller":"traceutil/trace.go:171","msg":"trace[775525837] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6633; }","duration":"137.240527ms","start":"2026-04-09T06:12:21.729516Z","end":"2026-04-09T06:12:21.866756Z","steps":["trace[775525837] 'agreement among raft nodes before linearized reading' (duration: 137.185576ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:12:21.867298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.670246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:16 size:141895"} {"level":"info","ts":"2026-04-09T06:12:21.86737Z","caller":"traceutil/trace.go:171","msg":"trace[1213871965] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:16; response_revision:6633; }","duration":"141.755188ms","start":"2026-04-09T06:12:21.725597Z","end":"2026-04-09T06:12:21.867352Z","steps":["trace[1213871965] 'agreement among raft nodes before linearized reading' (duration: 141.392749ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:12:23.667468Z","caller":"traceutil/trace.go:171","msg":"trace[608611076] transaction","detail":"{read_only:false; response_revision:6639; number_of_response:1; }","duration":"102.516952ms","start":"2026-04-09T06:12:23.564919Z","end":"2026-04-09T06:12:23.667436Z","steps":["trace[608611076] 'process raft request' (duration: 102.481391ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:12:23.667791Z","caller":"traceutil/trace.go:171","msg":"trace[431755298] transaction","detail":"{read_only:false; response_revision:6638; number_of_response:1; }","duration":"103.308132ms","start":"2026-04-09T06:12:23.564467Z","end":"2026-04-09T06:12:23.667776Z","steps":["trace[431755298] 'process raft request' (duration: 102.83945ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:12:24.120527Z","caller":"traceutil/trace.go:171","msg":"trace[1006779043] transaction","detail":"{read_only:false; response_revision:6645; number_of_response:1; }","duration":"146.85708ms","start":"2026-04-09T06:12:23.973637Z","end":"2026-04-09T06:12:24.120494Z","steps":["trace[1006779043] 'process raft request' (duration: 146.795019ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:12:24.121197Z","caller":"traceutil/trace.go:171","msg":"trace[1135800898] transaction","detail":"{read_only:false; response_revision:6644; number_of_response:1; }","duration":"150.024628ms","start":"2026-04-09T06:12:23.971151Z","end":"2026-04-09T06:12:24.121176Z","steps":["trace[1135800898] 'process raft request' (duration: 131.60727ms)","trace[1135800898] 'compare' (duration: 17.538097ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:12:25.805861Z","caller":"traceutil/trace.go:171","msg":"trace[212006011] transaction","detail":"{read_only:false; response_revision:6648; number_of_response:1; }","duration":"133.876816ms","start":"2026-04-09T06:12:25.67192Z","end":"2026-04-09T06:12:25.805797Z","steps":["trace[212006011] 'process raft request' (duration: 115.630672ms)","trace[212006011] 'compare' (duration: 17.908626ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:12:25.806449Z","caller":"traceutil/trace.go:171","msg":"trace[1113166105] transaction","detail":"{read_only:false; response_revision:6649; number_of_response:1; }","duration":"132.792739ms","start":"2026-04-09T06:12:25.673586Z","end":"2026-04-09T06:12:25.806379Z","steps":["trace[1113166105] 'process raft request' (duration: 132.321967ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:12:26.132736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.513136ms","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-04-09T06:12:26.132822Z","caller":"traceutil/trace.go:171","msg":"trace[577165285] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6649; }","duration":"161.63146ms","start":"2026-04-09T06:12:25.971172Z","end":"2026-04-09T06:12:26.132804Z","steps":["trace[577165285] 'range keys from in-memory index tree' (duration: 161.368183ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:12:26.132856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.177229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-zp9p7\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-09T06:12:26.132926Z","caller":"traceutil/trace.go:171","msg":"trace[923469738] range","detail":"{range_begin:/registry/pods/openstack/keepalived-zp9p7; range_end:; response_count:1; response_revision:6649; }","duration":"154.277362ms","start":"2026-04-09T06:12:25.978632Z","end":"2026-04-09T06:12:26.13291Z","steps":["trace[923469738] 'range keys from in-memory index tree' (duration: 154.048496ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:12:26.133184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.727634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:12:26.133238Z","caller":"traceutil/trace.go:171","msg":"trace[470554525] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:6649; }","duration":"217.827737ms","start":"2026-04-09T06:12:25.915399Z","end":"2026-04-09T06:12:26.133227Z","steps":["trace[470554525] 'count revisions from in-memory index tree' (duration: 217.583831ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:12:26.133735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.583513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-09T06:12:26.133784Z","caller":"traceutil/trace.go:171","msg":"trace[778572181] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6649; }","duration":"162.657085ms","start":"2026-04-09T06:12:25.971117Z","end":"2026-04-09T06:12:26.133774Z","steps":["trace[778572181] 'range keys from in-memory index tree' (duration: 162.46027ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:12:26.133271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.414713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-09T06:12:26.133911Z","caller":"traceutil/trace.go:171","msg":"trace[1515320338] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6649; }","duration":"136.09452ms","start":"2026-04-09T06:12:25.997804Z","end":"2026-04-09T06:12:26.133899Z","steps":["trace[1515320338] 'range keys from in-memory index tree' (duration: 135.27701ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:12:26.431627Z","caller":"traceutil/trace.go:171","msg":"trace[449026013] linearizableReadLoop","detail":"{readStateIndex:6893; appliedIndex:6892; }","duration":"108.20784ms","start":"2026-04-09T06:12:26.323401Z","end":"2026-04-09T06:12:26.431609Z","steps":["trace[449026013] 'read index received' (duration: 108.033826ms)","trace[449026013] 'applied index is now lower than readState.Index' (duration: 173.004µs)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:12:26.431777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.360855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T06:12:26.431859Z","caller":"traceutil/trace.go:171","msg":"trace[677628065] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6655; }","duration":"108.515538ms","start":"2026-04-09T06:12:26.323332Z","end":"2026-04-09T06:12:26.431848Z","steps":["trace[677628065] 'agreement among raft nodes before linearized reading' (duration: 108.352084ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:12:26.43233Z","caller":"traceutil/trace.go:171","msg":"trace[765947320] transaction","detail":"{read_only:false; response_revision:6655; number_of_response:1; }","duration":"220.108841ms","start":"2026-04-09T06:12:26.212208Z","end":"2026-04-09T06:12:26.432317Z","steps":["trace[765947320] 'process raft request' (duration: 219.300012ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:15:51.165149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.647531ms","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-04-09T06:15:51.165247Z","caller":"traceutil/trace.go:171","msg":"trace[340487622] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8271; }","duration":"216.797784ms","start":"2026-04-09T06:15:50.948429Z","end":"2026-04-09T06:15:51.165227Z","steps":["trace[340487622] 'range keys from in-memory index tree' (duration: 216.435316ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:15:52.895135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.687364ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-09T06:15:52.895315Z","caller":"traceutil/trace.go:171","msg":"trace[1761793431] transaction","detail":"{read_only:false; response_revision:8281; number_of_response:1; }","duration":"136.245234ms","start":"2026-04-09T06:15:52.759042Z","end":"2026-04-09T06:15:52.895287Z","steps":["trace[1761793431] 'process raft request' (duration: 35.279264ms)","trace[1761793431] 'compare' (duration: 100.53423ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T06:15:53.445537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.761399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-6994d986d6-5lt5k.18a49bafff16633a\" ","response":"range_response_count:1 size:1135"} {"level":"info","ts":"2026-04-09T06:15:53.445734Z","caller":"traceutil/trace.go:171","msg":"trace[1969917988] range","detail":"{range_begin:/registry/events/openstack/barbican-api-6994d986d6-5lt5k.18a49bafff16633a; range_end:; response_count:1; response_revision:8282; }","duration":"151.003314ms","start":"2026-04-09T06:15:53.294703Z","end":"2026-04-09T06:15:53.445707Z","steps":["trace[1969917988] 'range keys from in-memory index tree' (duration: 150.583754ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:16:00.922815Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6192} {"level":"info","ts":"2026-04-09T06:16:01.024591Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6192,"took":"99.418173ms","hash":2306458512,"current-db-size-bytes":58494976,"current-db-size":"58 MB","current-db-size-in-use-bytes":23257088,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-09T06:16:01.024668Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2306458512,"revision":6192,"compact-revision":3043} {"level":"info","ts":"2026-04-09T06:16:23.068062Z","caller":"traceutil/trace.go:171","msg":"trace[884189376] transaction","detail":"{read_only:false; response_revision:8497; number_of_response:1; }","duration":"104.62469ms","start":"2026-04-09T06:16:22.96341Z","end":"2026-04-09T06:16:23.068035Z","steps":["trace[884189376] 'process raft request' (duration: 104.452766ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:16:23.755203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.3345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-09T06:16:23.755306Z","caller":"traceutil/trace.go:171","msg":"trace[1874536610] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8498; }","duration":"137.472434ms","start":"2026-04-09T06:16:23.617807Z","end":"2026-04-09T06:16:23.75528Z","steps":["trace[1874536610] 'range keys from in-memory index tree' (duration: 137.177476ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:16:23.755571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.462147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-09T06:16:23.755604Z","caller":"traceutil/trace.go:171","msg":"trace[329826594] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8498; }","duration":"129.532739ms","start":"2026-04-09T06:16:23.626061Z","end":"2026-04-09T06:16:23.755594Z","steps":["trace[329826594] 'range keys from in-memory index tree' (duration: 129.287423ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:16:23.755749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.317769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-09T06:16:23.755818Z","caller":"traceutil/trace.go:171","msg":"trace[623529211] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8498; }","duration":"110.434232ms","start":"2026-04-09T06:16:23.645364Z","end":"2026-04-09T06:16:23.755798Z","steps":["trace[623529211] 'range keys from in-memory index tree' (duration: 110.118234ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:16:23.75612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.509375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-09T06:16:23.75615Z","caller":"traceutil/trace.go:171","msg":"trace[939290270] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8498; }","duration":"108.587926ms","start":"2026-04-09T06:16:23.647553Z","end":"2026-04-09T06:16:23.756141Z","steps":["trace[939290270] 'range keys from in-memory index tree' (duration: 108.364001ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:16:23.756245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.530387ms","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-04-09T06:16:23.756279Z","caller":"traceutil/trace.go:171","msg":"trace[1404607567] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8498; }","duration":"106.586729ms","start":"2026-04-09T06:16:23.649683Z","end":"2026-04-09T06:16:23.75627Z","steps":["trace[1404607567] 'range keys from in-memory index tree' (duration: 106.435055ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:16:32.759125Z","caller":"traceutil/trace.go:171","msg":"trace[1452025336] transaction","detail":"{read_only:false; response_revision:8589; number_of_response:1; }","duration":"148.463753ms","start":"2026-04-09T06:16:32.61063Z","end":"2026-04-09T06:16:32.759094Z","steps":["trace[1452025336] 'process raft request' (duration: 148.245308ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:16:32.944529Z","caller":"traceutil/trace.go:171","msg":"trace[721917468] transaction","detail":"{read_only:false; response_revision:8593; number_of_response:1; }","duration":"161.475041ms","start":"2026-04-09T06:16:32.783028Z","end":"2026-04-09T06:16:32.944503Z","steps":["trace[721917468] 'process raft request' (duration: 161.303697ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:16:32.982203Z","caller":"traceutil/trace.go:171","msg":"trace[1422834444] transaction","detail":"{read_only:false; response_revision:8594; number_of_response:1; }","duration":"106.601138ms","start":"2026-04-09T06:16:32.875564Z","end":"2026-04-09T06:16:32.982165Z","steps":["trace[1422834444] 'process raft request' (duration: 106.406574ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:16:34.033739Z","caller":"traceutil/trace.go:171","msg":"trace[1444961368] linearizableReadLoop","detail":"{readStateIndex:8905; appliedIndex:8904; }","duration":"178.062488ms","start":"2026-04-09T06:16:33.855653Z","end":"2026-04-09T06:16:34.033715Z","steps":["trace[1444961368] 'read index received' (duration: 177.889454ms)","trace[1444961368] 'applied index is now lower than readState.Index' (duration: 172.134µs)"],"step_count":2} {"level":"info","ts":"2026-04-09T06:16:34.033864Z","caller":"traceutil/trace.go:171","msg":"trace[687982792] transaction","detail":"{read_only:false; response_revision:8600; number_of_response:1; }","duration":"187.523928ms","start":"2026-04-09T06:16:33.846296Z","end":"2026-04-09T06:16:34.03382Z","steps":["trace[687982792] 'process raft request' (duration: 187.245052ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:16:34.034044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.369375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-09T06:16:34.034098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.795727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-09T06:16:34.034131Z","caller":"traceutil/trace.go:171","msg":"trace[850874178] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8600; }","duration":"178.536709ms","start":"2026-04-09T06:16:33.855572Z","end":"2026-04-09T06:16:34.034109Z","steps":["trace[850874178] 'agreement among raft nodes before linearized reading' (duration: 178.253903ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:16:34.034165Z","caller":"traceutil/trace.go:171","msg":"trace[77841493] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8600; }","duration":"174.93883ms","start":"2026-04-09T06:16:33.859211Z","end":"2026-04-09T06:16:34.03415Z","steps":["trace[77841493] 'agreement among raft nodes before linearized reading' (duration: 174.717385ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:16:34.034202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.412564ms","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-04-09T06:16:34.034241Z","caller":"traceutil/trace.go:171","msg":"trace[774402896] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8600; }","duration":"171.511966ms","start":"2026-04-09T06:16:33.862717Z","end":"2026-04-09T06:16:34.034229Z","steps":["trace[774402896] 'agreement among raft nodes before linearized reading' (duration: 171.351752ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:16:34.034288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.105269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"warn","ts":"2026-04-09T06:16:34.03424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.006459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-zp9p7\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-09T06:16:34.034325Z","caller":"traceutil/trace.go:171","msg":"trace[285154121] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8600; }","duration":"102.18907ms","start":"2026-04-09T06:16:33.932123Z","end":"2026-04-09T06:16:34.034312Z","steps":["trace[285154121] 'agreement among raft nodes before linearized reading' (duration: 101.982505ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:16:34.034349Z","caller":"traceutil/trace.go:171","msg":"trace[501912400] range","detail":"{range_begin:/registry/pods/openstack/keepalived-zp9p7; range_end:; response_count:1; response_revision:8600; }","duration":"163.132222ms","start":"2026-04-09T06:16:33.871197Z","end":"2026-04-09T06:16:34.034329Z","steps":["trace[501912400] 'agreement among raft nodes before linearized reading' (duration: 162.823704ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:16:34.034357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.361486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-09T06:16:34.034401Z","caller":"traceutil/trace.go:171","msg":"trace[1195398792] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8600; }","duration":"174.414718ms","start":"2026-04-09T06:16:33.859973Z","end":"2026-04-09T06:16:34.034388Z","steps":["trace[1195398792] 'agreement among raft nodes before linearized reading' (duration: 174.320176ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T06:16:34.034401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.016534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.118\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-09T06:16:34.034433Z","caller":"traceutil/trace.go:171","msg":"trace[444461415] range","detail":"{range_begin:/registry/masterleases/199.19.213.118; range_end:; response_count:1; response_revision:8600; }","duration":"153.075055ms","start":"2026-04-09T06:16:33.881349Z","end":"2026-04-09T06:16:34.034424Z","steps":["trace[444461415] 'agreement among raft nodes before linearized reading' (duration: 152.955412ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T06:17:25.089447Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000248f.wal"} {"level":"info","ts":"2026-04-09T06:18:34.75476Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"511d8c552db01fa8","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-09T06:18:34.763694Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-09T06:18:34.763876Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-09T06:21:00.928978Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8332} {"level":"info","ts":"2026-04-09T06:21:01.016348Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8332,"took":"84.503533ms","hash":3158762767,"current-db-size-bytes":58494976,"current-db-size":"58 MB","current-db-size-in-use-bytes":24940544,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-09T06:21:01.016441Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3158762767,"revision":8332,"compact-revision":6192} {"level":"info","ts":"2026-04-09T06:26:00.935479Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10720} {"level":"info","ts":"2026-04-09T06:26:01.026342Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10720,"took":"88.590208ms","hash":2908973391,"current-db-size-bytes":58494976,"current-db-size":"58 MB","current-db-size-in-use-bytes":21028864,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-09T06:26:01.026416Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2908973391,"revision":10720,"compact-revision":8332}