{"level":"warn","ts":"2026-05-28T21:37:59.056849Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-28T21:37:59.056922Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.223:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.223:2380","--initial-cluster=instance=https://199.204.45.223:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.223:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.223: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-05-28T21:37:59.056989Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-28T21:37:59.056997Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-05-28T21:37:59.057012Z","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-05-28T21:37:59.057597Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"]} {"level":"info","ts":"2026-05-28T21:37:59.057664Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.223: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-05-28T21:37:59.064378Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.49539ms"} {"level":"info","ts":"2026-05-28T21:37:59.077725Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"11f26225a5bb9fe3","cluster-id":"75c25101f01fd4c6"} {"level":"info","ts":"2026-05-28T21:37:59.077798Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=()"} {"level":"info","ts":"2026-05-28T21:37:59.07782Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 0"} {"level":"info","ts":"2026-05-28T21:37:59.077836Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 11f26225a5bb9fe3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-28T21:37:59.077848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 1"} {"level":"info","ts":"2026-05-28T21:37:59.077888Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"warn","ts":"2026-05-28T21:37:59.084725Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-28T21:37:59.086074Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-28T21:37:59.087125Z","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-05-28T21:37:59.089161Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"11f26225a5bb9fe3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-28T21:37:59.089331Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"11f26225a5bb9fe3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-28T21:37:59.089411Z","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-05-28T21:37:59.092281Z","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-05-28T21:37:59.092305Z","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-05-28T21:37:59.094164Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"info","ts":"2026-05-28T21:37:59.094369Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","added-peer-id":"11f26225a5bb9fe3","added-peer-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-05-28T21:37:59.098795Z","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-05-28T21:37:59.09886Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-05-28T21:37:59.098884Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-05-28T21:37:59.099896Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"11f26225a5bb9fe3","initial-advertise-peer-urls":["https://199.204.45.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-28T21:37:59.099944Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-28T21:37:59.178811Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 is starting a new election at term 1"} {"level":"info","ts":"2026-05-28T21:37:59.178888Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-28T21:37:59.178917Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgPreVoteResp from 11f26225a5bb9fe3 at term 1"} {"level":"info","ts":"2026-05-28T21:37:59.179098Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became candidate at term 2"} {"level":"info","ts":"2026-05-28T21:37:59.179201Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgVoteResp from 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-05-28T21:37:59.179297Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became leader at term 2"} {"level":"info","ts":"2026-05-28T21:37:59.179323Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 11f26225a5bb9fe3 elected leader 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-05-28T21:37:59.180446Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"11f26225a5bb9fe3","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.223:2379]}","request-path":"/0/members/11f26225a5bb9fe3/attributes","cluster-id":"75c25101f01fd4c6","publish-timeout":"7s"} {"level":"info","ts":"2026-05-28T21:37:59.18044Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-28T21:37:59.1805Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-28T21:37:59.181034Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T21:37:59.181876Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-28T21:37:59.181914Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-28T21:37:59.184204Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.223:2379"} {"level":"info","ts":"2026-05-28T21:37:59.193047Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-28T21:37:59.196186Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T21:37:59.196268Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T21:37:59.196292Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-05-28T21:38:37.653253Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521226477862595082,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-28T21:38:37.764901Z","caller":"traceutil/trace.go:171","msg":"trace[192080961] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"614.234077ms","start":"2026-05-28T21:38:37.150649Z","end":"2026-05-28T21:38:37.764883Z","steps":["trace[192080961] 'process raft request' (duration: 614.101015ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:37.765246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:37.150624Z","time spent":"614.339837ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9343,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-28T21:38:37.962272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.013242ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-28T21:38:37.962412Z","caller":"traceutil/trace.go:171","msg":"trace[1848470503] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:652; }","duration":"810.123345ms","start":"2026-05-28T21:38:37.152272Z","end":"2026-05-28T21:38:37.962396Z","steps":["trace[1848470503] 'read index received' (duration: 612.495331ms)","trace[1848470503] 'applied index is now lower than readState.Index' (duration: 197.626524ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T21:38:37.962564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"810.28132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-28T21:38:37.962591Z","caller":"traceutil/trace.go:171","msg":"trace[336692149] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:630; }","duration":"810.344635ms","start":"2026-05-28T21:38:37.152238Z","end":"2026-05-28T21:38:37.962583Z","steps":["trace[336692149] 'agreement among raft nodes before linearized reading' (duration: 810.220794ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:37.96265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:37.152227Z","time spent":"810.414641ms","remote":"127.0.0.1:41148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-28T21:38:38.103339Z","caller":"traceutil/trace.go:171","msg":"trace[1649276224] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"333.100617ms","start":"2026-05-28T21:38:37.770213Z","end":"2026-05-28T21:38:38.103313Z","steps":["trace[1649276224] 'process raft request' (duration: 332.955924ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:38.103731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:37.770191Z","time spent":"333.226219ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10353,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T21:38:38.642776Z","caller":"traceutil/trace.go:171","msg":"trace[1533610062] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:654; }","duration":"680.31852ms","start":"2026-05-28T21:38:37.962437Z","end":"2026-05-28T21:38:38.642755Z","steps":["trace[1533610062] 'read index received' (duration: 140.708311ms)","trace[1533610062] 'applied index is now lower than readState.Index' (duration: 539.609229ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T21:38:38.643132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"898.570497ms","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-05-28T21:38:38.643134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"896.064693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-28T21:38:38.643118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.096058677s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T21:38:38.643182Z","caller":"traceutil/trace.go:171","msg":"trace[1247882593] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:633; }","duration":"898.633572ms","start":"2026-05-28T21:38:37.744537Z","end":"2026-05-28T21:38:38.643171Z","steps":["trace[1247882593] 'agreement among raft nodes before linearized reading' (duration: 898.455186ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:38:38.643204Z","caller":"traceutil/trace.go:171","msg":"trace[1474544056] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:633; }","duration":"896.182203ms","start":"2026-05-28T21:38:37.747001Z","end":"2026-05-28T21:38:38.643183Z","steps":["trace[1474544056] 'agreement among raft nodes before linearized reading' (duration: 895.984816ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:38:38.643211Z","caller":"traceutil/trace.go:171","msg":"trace[1977706115] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:633; }","duration":"1.09619763s","start":"2026-05-28T21:38:37.546996Z","end":"2026-05-28T21:38:38.643193Z","steps":["trace[1977706115] 'agreement among raft nodes before linearized reading' (duration: 1.096055297s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:38.643217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:37.744498Z","time spent":"898.710539ms","remote":"127.0.0.1:41148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-28T21:38:38.643253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:37.546976Z","time spent":"1.096265865s","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-05-28T21:38:38.643435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.3246915s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T21:38:38.643466Z","caller":"traceutil/trace.go:171","msg":"trace[305631547] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:633; }","duration":"1.324756896s","start":"2026-05-28T21:38:37.318699Z","end":"2026-05-28T21:38:38.643456Z","steps":["trace[305631547] 'agreement among raft nodes before linearized reading' (duration: 1.324697441s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:38.643548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:37.318679Z","time spent":"1.32480746s","remote":"127.0.0.1:40890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-28T21:38:38.643683Z","caller":"traceutil/trace.go:171","msg":"trace[346186968] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"677.431124ms","start":"2026-05-28T21:38:37.966229Z","end":"2026-05-28T21:38:38.64366Z","steps":["trace[346186968] 'process raft request' (duration: 676.445495ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:38:38.64359Z","caller":"traceutil/trace.go:171","msg":"trace[780886820] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"694.30546ms","start":"2026-05-28T21:38:37.94915Z","end":"2026-05-28T21:38:38.643455Z","steps":["trace[780886820] 'process raft request' (duration: 693.418651ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:38.643747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"754.282758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T21:38:38.643804Z","caller":"traceutil/trace.go:171","msg":"trace[2072479004] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway; range_end:; response_count:0; response_revision:633; }","duration":"754.379717ms","start":"2026-05-28T21:38:37.889406Z","end":"2026-05-28T21:38:38.643786Z","steps":["trace[2072479004] 'agreement among raft nodes before linearized reading' (duration: 754.30185ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:38.643846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:37.889387Z","time spent":"754.448263ms","remote":"127.0.0.1:41100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":27,"request content":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway\" "} {"level":"warn","ts":"2026-05-28T21:38:38.643913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:37.746997Z","time spent":"896.896117ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-05-28T21:38:38.644005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:37.966215Z","time spent":"677.50829ms","remote":"127.0.0.1:41148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T21:38:38.644063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:37.949122Z","time spent":"694.799655ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4580,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-28T21:38:38.644302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.296546417s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T21:38:38.644363Z","caller":"traceutil/trace.go:171","msg":"trace[320490657] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:633; }","duration":"1.296652336s","start":"2026-05-28T21:38:37.347698Z","end":"2026-05-28T21:38:38.64435Z","steps":["trace[320490657] 'agreement among raft nodes before linearized reading' (duration: 1.296550337s)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:38.6444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:37.347679Z","time spent":"1.296711412s","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":27,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" "} {"level":"info","ts":"2026-05-28T21:38:38.672348Z","caller":"traceutil/trace.go:171","msg":"trace[805763450] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"522.786381ms","start":"2026-05-28T21:38:38.149538Z","end":"2026-05-28T21:38:38.672324Z","steps":["trace[805763450] 'process raft request' (duration: 522.741127ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:38.67266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:38.149516Z","time spent":"522.918403ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-28T21:38:38.672911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.79655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"} {"level":"info","ts":"2026-05-28T21:38:38.672883Z","caller":"traceutil/trace.go:171","msg":"trace[1761056732] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"560.713852ms","start":"2026-05-28T21:38:38.112108Z","end":"2026-05-28T21:38:38.672822Z","steps":["trace[1761056732] 'process raft request' (duration: 560.049092ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:38.672982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.405086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-28T21:38:38.673057Z","caller":"traceutil/trace.go:171","msg":"trace[1547946258] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:635; }","duration":"324.979766ms","start":"2026-05-28T21:38:38.348052Z","end":"2026-05-28T21:38:38.673032Z","steps":["trace[1547946258] 'agreement among raft nodes before linearized reading' (duration: 324.714652ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:38:38.673078Z","caller":"traceutil/trace.go:171","msg":"trace[350748690] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:635; }","duration":"318.543919ms","start":"2026-05-28T21:38:38.354513Z","end":"2026-05-28T21:38:38.673057Z","steps":["trace[350748690] 'agreement among raft nodes before linearized reading' (duration: 318.140003ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:38.673138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:38.112072Z","time spent":"560.925441ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10362,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T21:38:38.673176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:38.354504Z","time spent":"318.66203ms","remote":"127.0.0.1:41148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-28T21:38:38.673177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:38.348033Z","time spent":"325.124789ms","remote":"127.0.0.1:40928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":5199,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" "} {"level":"warn","ts":"2026-05-28T21:38:38.673525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.844137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-28T21:38:38.673554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.241628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"} {"level":"info","ts":"2026-05-28T21:38:38.673596Z","caller":"traceutil/trace.go:171","msg":"trace[311131679] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:635; }","duration":"199.958996ms","start":"2026-05-28T21:38:38.473618Z","end":"2026-05-28T21:38:38.673577Z","steps":["trace[311131679] 'agreement among raft nodes before linearized reading' (duration: 199.017353ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:38:38.673627Z","caller":"traceutil/trace.go:171","msg":"trace[1642609881] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:635; }","duration":"126.407733ms","start":"2026-05-28T21:38:38.547197Z","end":"2026-05-28T21:38:38.673605Z","steps":["trace[1642609881] 'agreement among raft nodes before linearized reading' (duration: 125.970934ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:45.482204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.741442ms","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-05-28T21:38:45.482291Z","caller":"traceutil/trace.go:171","msg":"trace[1343587965] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:695; }","duration":"496.859633ms","start":"2026-05-28T21:38:44.985412Z","end":"2026-05-28T21:38:45.482271Z","steps":["trace[1343587965] 'range keys from in-memory index tree' (duration: 496.60552ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:45.482348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:44.985395Z","time spent":"496.925429ms","remote":"127.0.0.1:41148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-28T21:38:45.482727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.370351ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-28T21:38:45.48279Z","caller":"traceutil/trace.go:171","msg":"trace[369685794] linearizableReadLoop","detail":"{readStateIndex:721; appliedIndex:720; }","duration":"164.999019ms","start":"2026-05-28T21:38:45.31778Z","end":"2026-05-28T21:38:45.482779Z","steps":["trace[369685794] 'read index received' (duration: 29.203µs)","trace[369685794] 'applied index is now lower than readState.Index' (duration: 164.968715ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:38:45.482968Z","caller":"traceutil/trace.go:171","msg":"trace[623075836] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"332.601408ms","start":"2026-05-28T21:38:45.150354Z","end":"2026-05-28T21:38:45.482955Z","steps":["trace[623075836] 'process raft request' (duration: 67.94383ms)","trace[623075836] 'compare' (duration: 263.965684ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T21:38:45.483019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:45.150328Z","time spent":"332.663623ms","remote":"127.0.0.1:41148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T21:38:45.483175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.368473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T21:38:45.483288Z","caller":"traceutil/trace.go:171","msg":"trace[1199841806] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:696; }","duration":"165.522507ms","start":"2026-05-28T21:38:45.317742Z","end":"2026-05-28T21:38:45.483265Z","steps":["trace[1199841806] 'agreement among raft nodes before linearized reading' (duration: 165.367833ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:39:51.971626Z","caller":"traceutil/trace.go:171","msg":"trace[636976356] transaction","detail":"{read_only:false; response_revision:1467; number_of_response:1; }","duration":"128.16001ms","start":"2026-05-28T21:39:51.843447Z","end":"2026-05-28T21:39:51.971608Z","steps":["trace[636976356] 'process raft request' (duration: 128.057579ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:40:19.926505Z","caller":"traceutil/trace.go:171","msg":"trace[1961751734] transaction","detail":"{read_only:false; response_revision:1909; number_of_response:1; }","duration":"134.319613ms","start":"2026-05-28T21:40:19.792158Z","end":"2026-05-28T21:40:19.926478Z","steps":["trace[1961751734] 'process raft request' (duration: 124.241652ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:40:19.934809Z","caller":"traceutil/trace.go:171","msg":"trace[560252461] transaction","detail":"{read_only:false; response_revision:1910; number_of_response:1; }","duration":"117.724672ms","start":"2026-05-28T21:40:19.817059Z","end":"2026-05-28T21:40:19.934784Z","steps":["trace[560252461] 'process raft request' (duration: 117.586038ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:40:28.56373Z","caller":"traceutil/trace.go:171","msg":"trace[767433163] transaction","detail":"{read_only:false; response_revision:1979; number_of_response:1; }","duration":"202.858065ms","start":"2026-05-28T21:40:28.360779Z","end":"2026-05-28T21:40:28.563638Z","steps":["trace[767433163] 'process raft request' (duration: 154.591719ms)","trace[767433163] 'compare' (duration: 48.009637ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:40:28.563932Z","caller":"traceutil/trace.go:171","msg":"trace[735890711] linearizableReadLoop","detail":"{readStateIndex:2055; appliedIndex:2054; }","duration":"180.283091ms","start":"2026-05-28T21:40:28.383293Z","end":"2026-05-28T21:40:28.563576Z","steps":["trace[735890711] 'read index received' (duration: 132.118409ms)","trace[735890711] 'applied index is now lower than readState.Index' (duration: 48.162772ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T21:40:28.56406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.709235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-05-28T21:40:28.564191Z","caller":"traceutil/trace.go:171","msg":"trace[283471614] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1979; }","duration":"180.891343ms","start":"2026-05-28T21:40:28.383269Z","end":"2026-05-28T21:40:28.56416Z","steps":["trace[283471614] 'agreement among raft nodes before linearized reading' (duration: 180.451237ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:40:32.104937Z","caller":"traceutil/trace.go:171","msg":"trace[809612819] transaction","detail":"{read_only:false; response_revision:2005; number_of_response:1; }","duration":"109.336611ms","start":"2026-05-28T21:40:31.995569Z","end":"2026-05-28T21:40:32.104906Z","steps":["trace[809612819] 'process raft request' (duration: 104.579474ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:40:54.576428Z","caller":"traceutil/trace.go:171","msg":"trace[699640645] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"169.004955ms","start":"2026-05-28T21:40:54.407392Z","end":"2026-05-28T21:40:54.576397Z","steps":["trace[699640645] 'process raft request' (duration: 168.791933ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:40:54.79015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.772148ms","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-05-28T21:40:54.790271Z","caller":"traceutil/trace.go:171","msg":"trace[1448390167] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2134; }","duration":"135.904814ms","start":"2026-05-28T21:40:54.654348Z","end":"2026-05-28T21:40:54.790252Z","steps":["trace[1448390167] 'range keys from in-memory index tree' (duration: 135.760978ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:40:54.790565Z","caller":"traceutil/trace.go:171","msg":"trace[493459344] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"134.236441ms","start":"2026-05-28T21:40:54.656207Z","end":"2026-05-28T21:40:54.790444Z","steps":["trace[493459344] 'process raft request' (duration: 125.101546ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:40:55.068641Z","caller":"traceutil/trace.go:171","msg":"trace[1057455616] transaction","detail":"{read_only:false; response_revision:2137; number_of_response:1; }","duration":"255.615702ms","start":"2026-05-28T21:40:54.812972Z","end":"2026-05-28T21:40:55.068588Z","steps":["trace[1057455616] 'process raft request' (duration: 156.66901ms)","trace[1057455616] 'compare' (duration: 98.640647ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:42:19.534602Z","caller":"traceutil/trace.go:171","msg":"trace[464527524] transaction","detail":"{read_only:false; response_revision:2700; number_of_response:1; }","duration":"199.069142ms","start":"2026-05-28T21:42:19.335504Z","end":"2026-05-28T21:42:19.534573Z","steps":["trace[464527524] 'process raft request' (duration: 198.875409ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:42:19.721191Z","caller":"traceutil/trace.go:171","msg":"trace[1198373430] transaction","detail":"{read_only:false; response_revision:2701; number_of_response:1; }","duration":"306.219187ms","start":"2026-05-28T21:42:19.414952Z","end":"2026-05-28T21:42:19.721171Z","steps":["trace[1198373430] 'process raft request' (duration: 304.356862ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:42:19.7213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:42:19.414917Z","time spent":"306.324674ms","remote":"127.0.0.1:41148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T21:46:02.126647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.667741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T21:46:02.126747Z","caller":"traceutil/trace.go:171","msg":"trace[2046518249] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:4569; }","duration":"106.822025ms","start":"2026-05-28T21:46:02.019908Z","end":"2026-05-28T21:46:02.12673Z","steps":["trace[2046518249] 'count revisions from in-memory index tree' (duration: 106.564339ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:46:02.126915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.540007ms","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-05-28T21:46:02.12699Z","caller":"traceutil/trace.go:171","msg":"trace[1716850200] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4569; }","duration":"135.66396ms","start":"2026-05-28T21:46:01.991307Z","end":"2026-05-28T21:46:02.126971Z","steps":["trace[1716850200] 'range keys from in-memory index tree' (duration: 135.377121ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:46:02.425986Z","caller":"traceutil/trace.go:171","msg":"trace[1589472318] linearizableReadLoop","detail":"{readStateIndex:4741; appliedIndex:4740; }","duration":"180.416485ms","start":"2026-05-28T21:46:02.245547Z","end":"2026-05-28T21:46:02.425963Z","steps":["trace[1589472318] 'read index received' (duration: 120.944313ms)","trace[1589472318] 'applied index is now lower than readState.Index' (duration: 59.471212ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:46:02.426108Z","caller":"traceutil/trace.go:171","msg":"trace[708244350] transaction","detail":"{read_only:false; response_revision:4571; number_of_response:1; }","duration":"232.776953ms","start":"2026-05-28T21:46:02.193318Z","end":"2026-05-28T21:46:02.426095Z","steps":["trace[708244350] 'process raft request' (duration: 173.153087ms)","trace[708244350] 'compare' (duration: 59.38825ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T21:46:02.426172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.466643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T21:46:02.426254Z","caller":"traceutil/trace.go:171","msg":"trace[1736575982] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4571; }","duration":"107.577236ms","start":"2026-05-28T21:46:02.318658Z","end":"2026-05-28T21:46:02.426236Z","steps":["trace[1736575982] 'agreement among raft nodes before linearized reading' (duration: 107.455763ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:46:02.426578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.033462ms","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-05-28T21:46:02.426611Z","caller":"traceutil/trace.go:171","msg":"trace[980099939] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4571; }","duration":"181.099594ms","start":"2026-05-28T21:46:02.245502Z","end":"2026-05-28T21:46:02.426602Z","steps":["trace[980099939] 'agreement among raft nodes before linearized reading' (duration: 180.960909ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:46:02.678908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.039126ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-28T21:46:02.679017Z","caller":"traceutil/trace.go:171","msg":"trace[742984167] linearizableReadLoop","detail":"{readStateIndex:4742; appliedIndex:4741; }","duration":"167.584495ms","start":"2026-05-28T21:46:02.511413Z","end":"2026-05-28T21:46:02.678998Z","steps":["trace[742984167] 'read index received' (duration: 58.336243ms)","trace[742984167] 'applied index is now lower than readState.Index' (duration: 109.246732ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:46:02.679122Z","caller":"traceutil/trace.go:171","msg":"trace[1666047162] transaction","detail":"{read_only:false; response_revision:4572; number_of_response:1; }","duration":"176.814896ms","start":"2026-05-28T21:46:02.502295Z","end":"2026-05-28T21:46:02.67911Z","steps":["trace[1666047162] 'process raft request' (duration: 67.474792ms)","trace[1666047162] 'compare' (duration: 108.930083ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T21:46:02.679296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.859252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5683"} {"level":"info","ts":"2026-05-28T21:46:02.67946Z","caller":"traceutil/trace.go:171","msg":"trace[486582005] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:4572; }","duration":"168.007025ms","start":"2026-05-28T21:46:02.511386Z","end":"2026-05-28T21:46:02.679393Z","steps":["trace[486582005] 'agreement among raft nodes before linearized reading' (duration: 167.733848ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:46:02.706951Z","caller":"traceutil/trace.go:171","msg":"trace[2096647062] transaction","detail":"{read_only:false; response_revision:4573; number_of_response:1; }","duration":"174.106623ms","start":"2026-05-28T21:46:02.532802Z","end":"2026-05-28T21:46:02.706909Z","steps":["trace[2096647062] 'process raft request' (duration: 173.99591ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:46:02.707136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.15455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-l9tks\" ","response":"range_response_count:1 size:9757"} {"level":"info","ts":"2026-05-28T21:46:02.707218Z","caller":"traceutil/trace.go:171","msg":"trace[33949803] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-l9tks; range_end:; response_count:1; response_revision:4573; }","duration":"175.281074ms","start":"2026-05-28T21:46:02.531922Z","end":"2026-05-28T21:46:02.707203Z","steps":["trace[33949803] 'agreement among raft nodes before linearized reading' (duration: 174.977606ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:46:02.977836Z","caller":"traceutil/trace.go:171","msg":"trace[1097066247] transaction","detail":"{read_only:false; response_revision:4577; number_of_response:1; }","duration":"139.22498ms","start":"2026-05-28T21:46:02.838585Z","end":"2026-05-28T21:46:02.97781Z","steps":["trace[1097066247] 'process raft request' (duration: 139.083746ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:46:05.437212Z","caller":"traceutil/trace.go:171","msg":"trace[1751130441] linearizableReadLoop","detail":"{readStateIndex:4821; appliedIndex:4820; }","duration":"114.74784ms","start":"2026-05-28T21:46:05.32244Z","end":"2026-05-28T21:46:05.437188Z","steps":["trace[1751130441] 'read index received' (duration: 114.545524ms)","trace[1751130441] 'applied index is now lower than readState.Index' (duration: 201.116µs)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:46:05.437334Z","caller":"traceutil/trace.go:171","msg":"trace[1913430122] transaction","detail":"{read_only:false; response_revision:4650; number_of_response:1; }","duration":"121.14059ms","start":"2026-05-28T21:46:05.316146Z","end":"2026-05-28T21:46:05.437286Z","steps":["trace[1913430122] 'process raft request' (duration: 120.900193ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:46:05.437532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.993827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-28T21:46:05.437558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.841293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-28T21:46:05.437629Z","caller":"traceutil/trace.go:171","msg":"trace[130777716] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4650; }","duration":"113.948717ms","start":"2026-05-28T21:46:05.323666Z","end":"2026-05-28T21:46:05.437615Z","steps":["trace[130777716] 'agreement among raft nodes before linearized reading' (duration: 113.726791ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:46:05.437574Z","caller":"traceutil/trace.go:171","msg":"trace[893269353] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4650; }","duration":"115.158961ms","start":"2026-05-28T21:46:05.322404Z","end":"2026-05-28T21:46:05.437563Z","steps":["trace[893269353] 'agreement among raft nodes before linearized reading' (duration: 114.923555ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:46:05.589746Z","caller":"traceutil/trace.go:171","msg":"trace[1784158600] transaction","detail":"{read_only:false; response_revision:4651; number_of_response:1; }","duration":"148.024536ms","start":"2026-05-28T21:46:05.441696Z","end":"2026-05-28T21:46:05.58972Z","steps":["trace[1784158600] 'process raft request' (duration: 144.94963ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:46:05.618367Z","caller":"traceutil/trace.go:171","msg":"trace[1257444334] transaction","detail":"{read_only:false; response_revision:4652; number_of_response:1; }","duration":"176.456007ms","start":"2026-05-28T21:46:05.441865Z","end":"2026-05-28T21:46:05.618321Z","steps":["trace[1257444334] 'process raft request' (duration: 176.289082ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:46:18.899389Z","caller":"traceutil/trace.go:171","msg":"trace[1174547590] transaction","detail":"{read_only:false; response_revision:4816; number_of_response:1; }","duration":"102.179129ms","start":"2026-05-28T21:46:18.797187Z","end":"2026-05-28T21:46:18.899366Z","steps":["trace[1174547590] 'process raft request' (duration: 102.045704ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:47:59.7844Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2913} {"level":"info","ts":"2026-05-28T21:47:59.869616Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2913,"took":"83.329063ms","hash":2617702101,"current-db-size-bytes":53547008,"current-db-size":"54 MB","current-db-size-in-use-bytes":29409280,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-28T21:47:59.869742Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2617702101,"revision":2913,"compact-revision":-1} {"level":"info","ts":"2026-05-28T21:50:00.89158Z","caller":"traceutil/trace.go:171","msg":"trace[1533862459] transaction","detail":"{read_only:false; response_revision:6446; number_of_response:1; }","duration":"113.784371ms","start":"2026-05-28T21:50:00.777767Z","end":"2026-05-28T21:50:00.891552Z","steps":["trace[1533862459] 'process raft request' (duration: 113.733628ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:50:00.891719Z","caller":"traceutil/trace.go:171","msg":"trace[1283280608] transaction","detail":"{read_only:false; response_revision:6445; number_of_response:1; }","duration":"115.133809ms","start":"2026-05-28T21:50:00.77655Z","end":"2026-05-28T21:50:00.891683Z","steps":["trace[1283280608] 'process raft request' (duration: 114.798699ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:50:05.693957Z","caller":"traceutil/trace.go:171","msg":"trace[1657874110] transaction","detail":"{read_only:false; response_revision:6475; number_of_response:1; }","duration":"137.373513ms","start":"2026-05-28T21:50:05.556287Z","end":"2026-05-28T21:50:05.69366Z","steps":["trace[1657874110] 'process raft request' (duration: 137.202433ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:50:33.553124Z","caller":"traceutil/trace.go:171","msg":"trace[1445321149] transaction","detail":"{read_only:false; response_revision:6669; number_of_response:1; }","duration":"130.389945ms","start":"2026-05-28T21:50:33.422702Z","end":"2026-05-28T21:50:33.553092Z","steps":["trace[1445321149] 'process raft request' (duration: 130.179272ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:52:59.791211Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5633} {"level":"info","ts":"2026-05-28T21:52:59.862719Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5633,"took":"69.677561ms","hash":2211303370,"current-db-size-bytes":53547008,"current-db-size":"54 MB","current-db-size-in-use-bytes":18309120,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-28T21:52:59.862774Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2211303370,"revision":5633,"compact-revision":2913}