{"level":"warn","ts":"2026-04-17T00:31:41.104292Z","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-17T00:31:41.104379Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.250: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.250:2380","--initial-cluster=instance=https://199.204.45.250:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.250:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.250: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-17T00:31:41.10445Z","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-17T00:31:41.104463Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.250:2380"]} {"level":"info","ts":"2026-04-17T00:31:41.104479Z","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-17T00:31:41.105087Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"]} {"level":"info","ts":"2026-04-17T00:31:41.105159Z","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.204.45.250:2380"],"listen-peer-urls":["https://199.204.45.250:2380"],"advertise-client-urls":["https://199.204.45.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.250: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-17T00:31:41.108934Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.532629ms"} {"level":"info","ts":"2026-04-17T00:31:41.114558Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d98d5f2c752cc52d","cluster-id":"c785b4aaf4bd3b11"} {"level":"info","ts":"2026-04-17T00:31:41.114686Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=()"} {"level":"info","ts":"2026-04-17T00:31:41.11472Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became follower at term 0"} {"level":"info","ts":"2026-04-17T00:31:41.114736Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d98d5f2c752cc52d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-17T00:31:41.114755Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became follower at term 1"} {"level":"info","ts":"2026-04-17T00:31:41.114813Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=(15676290522495632685)"} {"level":"warn","ts":"2026-04-17T00:31:41.12607Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-17T00:31:41.127776Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-17T00:31:41.129434Z","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-17T00:31:41.132329Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d98d5f2c752cc52d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-17T00:31:41.132558Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d98d5f2c752cc52d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-17T00:31:41.132653Z","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-17T00:31:41.133222Z","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-17T00:31:41.133259Z","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-17T00:31:41.134583Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=(15676290522495632685)"} {"level":"info","ts":"2026-04-17T00:31:41.134731Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c785b4aaf4bd3b11","local-member-id":"d98d5f2c752cc52d","added-peer-id":"d98d5f2c752cc52d","added-peer-peer-urls":["https://199.204.45.250:2380"]} {"level":"info","ts":"2026-04-17T00:31:41.136564Z","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-17T00:31:41.136711Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.250:2380"} {"level":"info","ts":"2026-04-17T00:31:41.136728Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.250:2380"} {"level":"info","ts":"2026-04-17T00:31:41.136932Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d98d5f2c752cc52d","initial-advertise-peer-urls":["https://199.204.45.250:2380"],"listen-peer-urls":["https://199.204.45.250:2380"],"advertise-client-urls":["https://199.204.45.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-17T00:31:41.136978Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-17T00:31:41.51573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d is starting a new election at term 1"} {"level":"info","ts":"2026-04-17T00:31:41.515793Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became pre-candidate at term 1"} {"level":"info","ts":"2026-04-17T00:31:41.515828Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d received MsgPreVoteResp from d98d5f2c752cc52d at term 1"} {"level":"info","ts":"2026-04-17T00:31:41.515852Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became candidate at term 2"} {"level":"info","ts":"2026-04-17T00:31:41.515865Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d received MsgVoteResp from d98d5f2c752cc52d at term 2"} {"level":"info","ts":"2026-04-17T00:31:41.515884Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became leader at term 2"} {"level":"info","ts":"2026-04-17T00:31:41.515905Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d98d5f2c752cc52d elected leader d98d5f2c752cc52d at term 2"} {"level":"info","ts":"2026-04-17T00:31:41.521087Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T00:31:41.521779Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d98d5f2c752cc52d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.250:2379]}","request-path":"/0/members/d98d5f2c752cc52d/attributes","cluster-id":"c785b4aaf4bd3b11","publish-timeout":"7s"} {"level":"info","ts":"2026-04-17T00:31:41.521824Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T00:31:41.521866Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T00:31:41.522108Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-17T00:31:41.522196Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-17T00:31:41.52507Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-17T00:31:41.5288Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c785b4aaf4bd3b11","local-member-id":"d98d5f2c752cc52d","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T00:31:41.528963Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T00:31:41.529043Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T00:31:41.528157Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.250:2379"} {"level":"info","ts":"2026-04-17T00:32:02.961615Z","caller":"traceutil/trace.go:171","msg":"trace[417442321] transaction","detail":"{read_only:false; response_revision:455; number_of_response:1; }","duration":"105.154801ms","start":"2026-04-17T00:32:02.856433Z","end":"2026-04-17T00:32:02.961588Z","steps":["trace[417442321] 'process raft request' (duration: 105.003647ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:32:12.019958Z","caller":"traceutil/trace.go:171","msg":"trace[2130244221] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"230.988441ms","start":"2026-04-17T00:32:11.788932Z","end":"2026-04-17T00:32:12.019921Z","steps":["trace[2130244221] 'process raft request' (duration: 215.92412ms)","trace[2130244221] 'compare' (duration: 14.853175ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:32:12.020247Z","caller":"traceutil/trace.go:171","msg":"trace[334157239] linearizableReadLoop","detail":"{readStateIndex:604; appliedIndex:603; }","duration":"220.504997ms","start":"2026-04-17T00:32:11.799678Z","end":"2026-04-17T00:32:12.020183Z","steps":["trace[334157239] 'read index received' (duration: 205.21938ms)","trace[334157239] 'applied index is now lower than readState.Index' (duration: 15.283067ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:32:12.020342Z","caller":"traceutil/trace.go:171","msg":"trace[842775948] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"152.820834ms","start":"2026-04-17T00:32:11.867491Z","end":"2026-04-17T00:32:12.020312Z","steps":["trace[842775948] 'process raft request' (duration: 152.517855ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:32:12.020585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.859828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:80703"} {"level":"info","ts":"2026-04-17T00:32:12.020655Z","caller":"traceutil/trace.go:171","msg":"trace[883524999] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:583; }","duration":"220.976281ms","start":"2026-04-17T00:32:11.799666Z","end":"2026-04-17T00:32:12.020642Z","steps":["trace[883524999] 'agreement among raft nodes before linearized reading' (duration: 220.657102ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:32:17.147234Z","caller":"traceutil/trace.go:171","msg":"trace[1665687996] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:638; }","duration":"120.533361ms","start":"2026-04-17T00:32:17.026674Z","end":"2026-04-17T00:32:17.147208Z","steps":["trace[1665687996] 'read index received' (duration: 120.248453ms)","trace[1665687996] 'applied index is now lower than readState.Index' (duration: 283.908µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:32:17.147289Z","caller":"traceutil/trace.go:171","msg":"trace[372871334] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"396.275194ms","start":"2026-04-17T00:32:16.75098Z","end":"2026-04-17T00:32:17.147255Z","steps":["trace[372871334] 'process raft request' (duration: 396.036997ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:32:17.147535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.84767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-17T00:32:17.147608Z","caller":"traceutil/trace.go:171","msg":"trace[1519112493] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:616; }","duration":"120.969543ms","start":"2026-04-17T00:32:17.026626Z","end":"2026-04-17T00:32:17.147596Z","steps":["trace[1519112493] 'agreement among raft nodes before linearized reading' (duration: 120.728827ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:32:17.147804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.33583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-llb4x\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-17T00:32:17.147851Z","caller":"traceutil/trace.go:171","msg":"trace[1780723008] range","detail":"{range_begin:/registry/pods/kube-system/cilium-llb4x; range_end:; response_count:1; response_revision:616; }","duration":"103.476674ms","start":"2026-04-17T00:32:17.04436Z","end":"2026-04-17T00:32:17.147837Z","steps":["trace[1780723008] 'agreement among raft nodes before linearized reading' (duration: 103.117934ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:32:17.14806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:32:16.750962Z","time spent":"396.532951ms","remote":"127.0.0.1:34982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T00:33:55.543499Z","caller":"traceutil/trace.go:171","msg":"trace[1366981219] linearizableReadLoop","detail":"{readStateIndex:1948; appliedIndex:1947; }","duration":"130.283634ms","start":"2026-04-17T00:33:55.413199Z","end":"2026-04-17T00:33:55.543483Z","steps":["trace[1366981219] 'read index received' (duration: 130.16468ms)","trace[1366981219] 'applied index is now lower than readState.Index' (duration: 118.194µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:33:55.543542Z","caller":"traceutil/trace.go:171","msg":"trace[2139488294] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"202.867616ms","start":"2026-04-17T00:33:55.340642Z","end":"2026-04-17T00:33:55.543509Z","steps":["trace[2139488294] 'process raft request' (duration: 202.726512ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:33:55.543677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.47351ms","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-17T00:33:55.543704Z","caller":"traceutil/trace.go:171","msg":"trace[1491919960] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1873; }","duration":"130.517701ms","start":"2026-04-17T00:33:55.41318Z","end":"2026-04-17T00:33:55.543698Z","steps":["trace[1491919960] 'agreement among raft nodes before linearized reading' (duration: 130.410598ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:33:55.9171Z","caller":"traceutil/trace.go:171","msg":"trace[1457798402] linearizableReadLoop","detail":"{readStateIndex:1951; appliedIndex:1950; }","duration":"195.697535ms","start":"2026-04-17T00:33:55.721357Z","end":"2026-04-17T00:33:55.917054Z","steps":["trace[1457798402] 'read index received' (duration: 185.372384ms)","trace[1457798402] 'applied index is now lower than readState.Index' (duration: 10.32262ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:33:55.917158Z","caller":"traceutil/trace.go:171","msg":"trace[126312770] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"260.657241ms","start":"2026-04-17T00:33:55.656471Z","end":"2026-04-17T00:33:55.917129Z","steps":["trace[126312770] 'process raft request' (duration: 250.243938ms)","trace[126312770] 'compare' (duration: 10.047322ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:33:55.917368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.993013ms","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-17T00:33:55.917442Z","caller":"traceutil/trace.go:171","msg":"trace[983417397] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1876; }","duration":"196.123606ms","start":"2026-04-17T00:33:55.721302Z","end":"2026-04-17T00:33:55.917425Z","steps":["trace[983417397] 'agreement among raft nodes before linearized reading' (duration: 195.91229ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:33:55.917528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.078089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-17T00:33:55.917539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.867623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-17T00:33:55.917601Z","caller":"traceutil/trace.go:171","msg":"trace[1537624832] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1876; }","duration":"135.173371ms","start":"2026-04-17T00:33:55.782412Z","end":"2026-04-17T00:33:55.917585Z","steps":["trace[1537624832] 'agreement among raft nodes before linearized reading' (duration: 135.003747ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:33:55.917615Z","caller":"traceutil/trace.go:171","msg":"trace[1643418248] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1876; }","duration":"129.967376ms","start":"2026-04-17T00:33:55.787628Z","end":"2026-04-17T00:33:55.917595Z","steps":["trace[1643418248] 'agreement among raft nodes before linearized reading' (duration: 129.811041ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:34:11.75681Z","caller":"traceutil/trace.go:171","msg":"trace[883711296] transaction","detail":"{read_only:false; response_revision:2009; number_of_response:1; }","duration":"118.827822ms","start":"2026-04-17T00:34:11.637955Z","end":"2026-04-17T00:34:11.756783Z","steps":["trace[883711296] 'process raft request' (duration: 118.674858ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:34:44.885322Z","caller":"traceutil/trace.go:171","msg":"trace[1829389055] transaction","detail":"{read_only:false; response_revision:2191; number_of_response:1; }","duration":"110.365876ms","start":"2026-04-17T00:34:44.774933Z","end":"2026-04-17T00:34:44.885299Z","steps":["trace[1829389055] 'process raft request' (duration: 110.226543ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:34:50.984116Z","caller":"traceutil/trace.go:171","msg":"trace[1370086403] transaction","detail":"{read_only:false; response_revision:2222; number_of_response:1; }","duration":"111.044525ms","start":"2026-04-17T00:34:50.873048Z","end":"2026-04-17T00:34:50.984093Z","steps":["trace[1370086403] 'process raft request' (duration: 110.905421ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:34:51.003829Z","caller":"traceutil/trace.go:171","msg":"trace[739108735] transaction","detail":"{read_only:false; response_revision:2223; number_of_response:1; }","duration":"100.069049ms","start":"2026-04-17T00:34:50.903733Z","end":"2026-04-17T00:34:51.003802Z","steps":["trace[739108735] 'process raft request' (duration: 99.856163ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:38:25.533287Z","caller":"traceutil/trace.go:171","msg":"trace[510342807] transaction","detail":"{read_only:false; response_revision:3762; number_of_response:1; }","duration":"156.503371ms","start":"2026-04-17T00:38:25.376757Z","end":"2026-04-17T00:38:25.53326Z","steps":["trace[510342807] 'process raft request' (duration: 156.343627ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:39:51.505371Z","caller":"traceutil/trace.go:171","msg":"trace[3174416] transaction","detail":"{read_only:false; response_revision:4932; number_of_response:1; }","duration":"159.407567ms","start":"2026-04-17T00:39:51.345938Z","end":"2026-04-17T00:39:51.505345Z","steps":["trace[3174416] 'process raft request' (duration: 159.297114ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:39:51.505408Z","caller":"traceutil/trace.go:171","msg":"trace[1726083383] linearizableReadLoop","detail":"{readStateIndex:5120; appliedIndex:5120; }","duration":"149.021875ms","start":"2026-04-17T00:39:51.356349Z","end":"2026-04-17T00:39:51.50537Z","steps":["trace[1726083383] 'read index received' (duration: 149.004225ms)","trace[1726083383] 'applied index is now lower than readState.Index' (duration: 10.66µs)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:39:51.505499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.137928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:39:51.505545Z","caller":"traceutil/trace.go:171","msg":"trace[38511997] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:4932; }","duration":"149.19778ms","start":"2026-04-17T00:39:51.356334Z","end":"2026-04-17T00:39:51.505532Z","steps":["trace[38511997] 'agreement among raft nodes before linearized reading' (duration: 149.109617ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:39:51.512981Z","caller":"traceutil/trace.go:171","msg":"trace[332743011] transaction","detail":"{read_only:false; response_revision:4933; number_of_response:1; }","duration":"107.499528ms","start":"2026-04-17T00:39:51.405453Z","end":"2026-04-17T00:39:51.512953Z","steps":["trace[332743011] 'process raft request' (duration: 107.364464ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:39:51.760676Z","caller":"traceutil/trace.go:171","msg":"trace[1212271482] transaction","detail":"{read_only:false; response_revision:4938; number_of_response:1; }","duration":"126.273487ms","start":"2026-04-17T00:39:51.63436Z","end":"2026-04-17T00:39:51.760633Z","steps":["trace[1212271482] 'process raft request' (duration: 102.227275ms)","trace[1212271482] 'compare' (duration: 23.755495ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:40:02.498684Z","caller":"traceutil/trace.go:171","msg":"trace[796821205] transaction","detail":"{read_only:false; response_revision:5164; number_of_response:1; }","duration":"104.892612ms","start":"2026-04-17T00:40:02.393753Z","end":"2026-04-17T00:40:02.498646Z","steps":["trace[796821205] 'process raft request' (duration: 77.049133ms)","trace[796821205] 'compare' (duration: 27.346486ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:40:10.657418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.526595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ed1a3a9d-9944-4ddf-ac0e-510309701d6f\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-04-17T00:40:10.657555Z","caller":"traceutil/trace.go:171","msg":"trace[373782043] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ed1a3a9d-9944-4ddf-ac0e-510309701d6f; range_end:; response_count:1; response_revision:5333; }","duration":"110.71845ms","start":"2026-04-17T00:40:10.546808Z","end":"2026-04-17T00:40:10.657527Z","steps":["trace[373782043] 'range keys from in-memory index tree' (duration: 110.31856ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:40:10.796225Z","caller":"traceutil/trace.go:171","msg":"trace[1574269325] transaction","detail":"{read_only:false; response_revision:5334; number_of_response:1; }","duration":"130.568142ms","start":"2026-04-17T00:40:10.665603Z","end":"2026-04-17T00:40:10.796171Z","steps":["trace[1574269325] 'process raft request' (duration: 130.068498ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:40:11.089041Z","caller":"traceutil/trace.go:171","msg":"trace[1044328415] transaction","detail":"{read_only:false; response_revision:5335; number_of_response:1; }","duration":"281.212212ms","start":"2026-04-17T00:40:10.807803Z","end":"2026-04-17T00:40:11.089015Z","steps":["trace[1044328415] 'process raft request' (duration: 251.117061ms)","trace[1044328415] 'compare' (duration: 29.981758ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:40:11.121108Z","caller":"traceutil/trace.go:171","msg":"trace[389714157] transaction","detail":"{read_only:false; response_revision:5336; number_of_response:1; }","duration":"223.661752ms","start":"2026-04-17T00:40:10.897409Z","end":"2026-04-17T00:40:11.12107Z","steps":["trace[389714157] 'process raft request' (duration: 223.424696ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:40:11.121606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.394097ms","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-17T00:40:11.121725Z","caller":"traceutil/trace.go:171","msg":"trace[1764352509] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5336; }","duration":"134.642004ms","start":"2026-04-17T00:40:10.987059Z","end":"2026-04-17T00:40:11.121701Z","steps":["trace[1764352509] 'agreement among raft nodes before linearized reading' (duration: 134.280954ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:40:11.121002Z","caller":"traceutil/trace.go:171","msg":"trace[414601367] linearizableReadLoop","detail":"{readStateIndex:5536; appliedIndex:5534; }","duration":"133.864392ms","start":"2026-04-17T00:40:10.987116Z","end":"2026-04-17T00:40:11.120981Z","steps":["trace[414601367] 'read index received' (duration: 71.813379ms)","trace[414601367] 'applied index is now lower than readState.Index' (duration: 62.049843ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:40:11.253336Z","caller":"traceutil/trace.go:171","msg":"trace[58023333] transaction","detail":"{read_only:false; response_revision:5337; number_of_response:1; }","duration":"158.735471ms","start":"2026-04-17T00:40:11.094569Z","end":"2026-04-17T00:40:11.253305Z","steps":["trace[58023333] 'process raft request' (duration: 146.745004ms)","trace[58023333] 'compare' (duration: 11.770481ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:40:11.253397Z","caller":"traceutil/trace.go:171","msg":"trace[616613027] transaction","detail":"{read_only:false; response_revision:5338; number_of_response:1; }","duration":"158.771071ms","start":"2026-04-17T00:40:11.094607Z","end":"2026-04-17T00:40:11.253378Z","steps":["trace[616613027] 'process raft request' (duration: 158.637278ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:40:11.253547Z","caller":"traceutil/trace.go:171","msg":"trace[341562087] transaction","detail":"{read_only:false; response_revision:5339; number_of_response:1; }","duration":"156.387597ms","start":"2026-04-17T00:40:11.097132Z","end":"2026-04-17T00:40:11.25352Z","steps":["trace[341562087] 'process raft request' (duration: 156.155871ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:40:11.253554Z","caller":"traceutil/trace.go:171","msg":"trace[1988947577] transaction","detail":"{read_only:false; response_revision:5340; number_of_response:1; }","duration":"127.983622ms","start":"2026-04-17T00:40:11.125541Z","end":"2026-04-17T00:40:11.253524Z","steps":["trace[1988947577] 'process raft request' (duration: 127.789267ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:40:11.253618Z","caller":"traceutil/trace.go:171","msg":"trace[952900037] linearizableReadLoop","detail":"{readStateIndex:5539; appliedIndex:5536; }","duration":"131.740405ms","start":"2026-04-17T00:40:11.121868Z","end":"2026-04-17T00:40:11.253609Z","steps":["trace[952900037] 'read index received' (duration: 119.369477ms)","trace[952900037] 'applied index is now lower than readState.Index' (duration: 12.369808ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:40:11.253824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.467679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-9vq4w\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-17T00:40:11.253853Z","caller":"traceutil/trace.go:171","msg":"trace[721610221] range","detail":"{range_begin:/registry/pods/openstack/keepalived-9vq4w; range_end:; response_count:1; response_revision:5340; }","duration":"178.548361ms","start":"2026-04-17T00:40:11.075298Z","end":"2026-04-17T00:40:11.253847Z","steps":["trace[721610221] 'agreement among raft nodes before linearized reading' (duration: 178.378336ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:41:41.551184Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3025} {"level":"info","ts":"2026-04-17T00:41:41.639895Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3025,"took":"86.97368ms","hash":1969119396,"current-db-size-bytes":58777600,"current-db-size":"59 MB","current-db-size-in-use-bytes":31850496,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-17T00:41:41.639968Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1969119396,"revision":3025,"compact-revision":-1} {"level":"warn","ts":"2026-04-17T00:42:18.391344Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185679237772029,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T00:42:18.891971Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185679237772029,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T00:42:19.392097Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185679237772029,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T00:42:19.893176Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185679237772029,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T00:42:20.393467Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185679237772029,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T00:42:20.633184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999925544s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-17T00:42:20.633334Z","caller":"traceutil/trace.go:171","msg":"trace[2020429748] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000131179s","start":"2026-04-17T00:42:18.633184Z","end":"2026-04-17T00:42:20.633315Z","steps":["trace[2020429748] 'agreement among raft nodes before linearized reading' (duration: 1.999956535s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:20.633387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:18.633168Z","time spent":"2.000209252s","remote":"127.0.0.1:34428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/17 00:42:20 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-17T00:42:20.893978Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185679237772029,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T00:42:21.395007Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208185679237772029,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-17T00:42:21.65449Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.773476619s","expected-duration":"1s"} {"level":"info","ts":"2026-04-17T00:42:21.654969Z","caller":"traceutil/trace.go:171","msg":"trace[972512624] transaction","detail":"{read_only:false; response_revision:6374; number_of_response:1; }","duration":"3.774060015s","start":"2026-04-17T00:42:17.880889Z","end":"2026-04-17T00:42:21.654949Z","steps":["trace[972512624] 'process raft request' (duration: 3.77389729s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:21.655373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:17.880867Z","time spent":"3.77423991s","remote":"127.0.0.1:34676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:42:21.658043Z","caller":"traceutil/trace.go:171","msg":"trace[1626770018] transaction","detail":"{read_only:false; response_revision:6375; number_of_response:1; }","duration":"3.073806317s","start":"2026-04-17T00:42:18.584212Z","end":"2026-04-17T00:42:21.658018Z","steps":["trace[1626770018] 'process raft request' (duration: 3.073625212s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:21.658191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:18.58419Z","time spent":"3.07391449s","remote":"127.0.0.1:34676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:42:21.658298Z","caller":"traceutil/trace.go:171","msg":"trace[1693622846] transaction","detail":"{read_only:false; response_revision:6376; number_of_response:1; }","duration":"3.056317535s","start":"2026-04-17T00:42:18.60195Z","end":"2026-04-17T00:42:21.658267Z","steps":["trace[1693622846] 'process raft request' (duration: 3.056024707s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:21.658466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:18.601919Z","time spent":"3.056466009s","remote":"127.0.0.1:34676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:42:21.658957Z","caller":"traceutil/trace.go:171","msg":"trace[876253237] transaction","detail":"{read_only:false; response_revision:6377; number_of_response:1; }","duration":"3.055048211s","start":"2026-04-17T00:42:18.603896Z","end":"2026-04-17T00:42:21.658944Z","steps":["trace[876253237] 'process raft request' (duration: 3.054581188s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:21.659034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:18.60388Z","time spent":"3.055110592s","remote":"127.0.0.1:34676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:42:21.65904Z","caller":"traceutil/trace.go:171","msg":"trace[1247434003] transaction","detail":"{read_only:false; response_revision:6378; number_of_response:1; }","duration":"3.053848917s","start":"2026-04-17T00:42:18.60518Z","end":"2026-04-17T00:42:21.659029Z","steps":["trace[1247434003] 'process raft request' (duration: 3.053647342s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:21.659167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:18.605152Z","time spent":"3.05396356s","remote":"127.0.0.1:34676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:42:21.659712Z","caller":"traceutil/trace.go:171","msg":"trace[1210696015] transaction","detail":"{read_only:false; response_revision:6379; number_of_response:1; }","duration":"2.920759589s","start":"2026-04-17T00:42:18.738933Z","end":"2026-04-17T00:42:21.659692Z","steps":["trace[1210696015] 'process raft request' (duration: 2.920590775s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:21.65986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:18.738888Z","time spent":"2.920914423s","remote":"127.0.0.1:34676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:42:21.66234Z","caller":"traceutil/trace.go:171","msg":"trace[521244796] linearizableReadLoop","detail":"{readStateIndex:6610; appliedIndex:6602; }","duration":"3.772070631s","start":"2026-04-17T00:42:17.890249Z","end":"2026-04-17T00:42:21.66232Z","steps":["trace[521244796] 'read index received' (duration: 3.764600745s)","trace[521244796] 'applied index is now lower than readState.Index' (duration: 7.468206ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:42:21.662366Z","caller":"traceutil/trace.go:171","msg":"trace[215979204] transaction","detail":"{read_only:false; response_revision:6380; number_of_response:1; }","duration":"1.975481379s","start":"2026-04-17T00:42:19.68686Z","end":"2026-04-17T00:42:21.662342Z","steps":["trace[215979204] 'process raft request' (duration: 1.975309545s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:21.66257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.772327217s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-9vq4w\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-17T00:42:21.66263Z","caller":"traceutil/trace.go:171","msg":"trace[58262553] range","detail":"{range_begin:/registry/pods/openstack/keepalived-9vq4w; range_end:; response_count:1; response_revision:6380; }","duration":"3.77243511s","start":"2026-04-17T00:42:17.890185Z","end":"2026-04-17T00:42:21.66262Z","steps":["trace[58262553] 'agreement among raft nodes before linearized reading' (duration: 3.772230614s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:21.662657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:17.890159Z","time spent":"3.772491502s","remote":"127.0.0.1:34600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6555,"request content":"key:\"/registry/pods/openstack/keepalived-9vq4w\" "} {"level":"warn","ts":"2026-04-17T00:42:21.66266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.270343565s","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":"warn","ts":"2026-04-17T00:42:21.662614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:19.686832Z","time spent":"1.975731276s","remote":"127.0.0.1:34676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T00:42:21.663013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.31193278s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-17T00:42:21.663024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.960989988s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-17T00:42:21.663056Z","caller":"traceutil/trace.go:171","msg":"trace[157526709] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6380; }","duration":"3.312028733s","start":"2026-04-17T00:42:18.351016Z","end":"2026-04-17T00:42:21.663045Z","steps":["trace[157526709] 'agreement among raft nodes before linearized reading' (duration: 3.31194375s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:21.663175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:18.350988Z","time spent":"3.312172846s","remote":"127.0.0.1:34676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-17T00:42:21.663064Z","caller":"traceutil/trace.go:171","msg":"trace[1191502751] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6380; }","duration":"2.961091201s","start":"2026-04-17T00:42:18.701961Z","end":"2026-04-17T00:42:21.663052Z","steps":["trace[1191502751] 'agreement among raft nodes before linearized reading' (duration: 2.960941917s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:21.663276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:18.701927Z","time spent":"2.961327157s","remote":"127.0.0.1:34676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-17T00:42:21.662789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.765800041s","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":"info","ts":"2026-04-17T00:42:21.663387Z","caller":"traceutil/trace.go:171","msg":"trace[24080332] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:6380; }","duration":"1.766442919s","start":"2026-04-17T00:42:19.89693Z","end":"2026-04-17T00:42:21.663373Z","steps":["trace[24080332] 'agreement among raft nodes before linearized reading' (duration: 1.765826242s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:21.663429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:19.896906Z","time spent":"1.766510351s","remote":"127.0.0.1:42376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":6,"response size":31,"request content":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true "} {"level":"warn","ts":"2026-04-17T00:42:21.662819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.641970809s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-17T00:42:21.663562Z","caller":"traceutil/trace.go:171","msg":"trace[384159439] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6380; }","duration":"1.642767351s","start":"2026-04-17T00:42:20.020783Z","end":"2026-04-17T00:42:21.66355Z","steps":["trace[384159439] 'agreement among raft nodes before linearized reading' (duration: 1.641930208s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:21.662847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.319143348s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/keystone-api\" ","response":"range_response_count:1 size:674"} {"level":"info","ts":"2026-04-17T00:42:21.663682Z","caller":"traceutil/trace.go:171","msg":"trace[2117848727] range","detail":"{range_begin:/registry/services/endpoints/openstack/keystone-api; range_end:; response_count:1; response_revision:6380; }","duration":"3.320016452s","start":"2026-04-17T00:42:18.343655Z","end":"2026-04-17T00:42:21.663672Z","steps":["trace[2117848727] 'agreement among raft nodes before linearized reading' (duration: 3.318929532s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:21.663675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:20.020758Z","time spent":"1.642904915s","remote":"127.0.0.1:34600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12240,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-17T00:42:21.663828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:18.343632Z","time spent":"3.320077494s","remote":"127.0.0.1:34592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":698,"request content":"key:\"/registry/services/endpoints/openstack/keystone-api\" "} {"level":"warn","ts":"2026-04-17T00:42:21.662865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.029549471s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:42:21.663915Z","caller":"traceutil/trace.go:171","msg":"trace[1410321617] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6380; }","duration":"1.030629211s","start":"2026-04-17T00:42:20.633269Z","end":"2026-04-17T00:42:21.663898Z","steps":["trace[1410321617] 'agreement among raft nodes before linearized reading' (duration: 1.029558432s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:21.664012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:20.633227Z","time spent":"1.030762385s","remote":"127.0.0.1:34416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-17T00:42:21.662935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.139204149s","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-17T00:42:21.664179Z","caller":"traceutil/trace.go:171","msg":"trace[1010513394] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6380; }","duration":"3.140465194s","start":"2026-04-17T00:42:18.523699Z","end":"2026-04-17T00:42:21.664164Z","steps":["trace[1010513394] 'agreement among raft nodes before linearized reading' (duration: 3.139173699s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:21.664227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:18.523695Z","time spent":"3.140517776s","remote":"127.0.0.1:34676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-17T00:42:21.662946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.141157763s","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-17T00:42:21.664365Z","caller":"traceutil/trace.go:171","msg":"trace[491234270] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6380; }","duration":"3.142568002s","start":"2026-04-17T00:42:18.52178Z","end":"2026-04-17T00:42:21.664348Z","steps":["trace[491234270] 'agreement among raft nodes before linearized reading' (duration: 3.141114872s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:21.664429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:18.521761Z","time spent":"3.142647124s","remote":"127.0.0.1:34676","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":"info","ts":"2026-04-17T00:42:21.662732Z","caller":"traceutil/trace.go:171","msg":"trace[1576025994] range","detail":"{range_begin:/registry/secretgen.k14s.io/rsakeys/; range_end:/registry/secretgen.k14s.io/rsakeys0; response_count:0; response_revision:6380; }","duration":"2.270460319s","start":"2026-04-17T00:42:19.392253Z","end":"2026-04-17T00:42:21.662714Z","steps":["trace[1576025994] 'agreement among raft nodes before linearized reading' (duration: 2.270335945s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:21.664525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:42:19.392229Z","time spent":"2.272278159s","remote":"127.0.0.1:59634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":29,"request content":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true "} {"level":"info","ts":"2026-04-17T00:42:23.785005Z","caller":"traceutil/trace.go:171","msg":"trace[2082540513] transaction","detail":"{read_only:false; response_revision:6387; number_of_response:1; }","duration":"121.783606ms","start":"2026-04-17T00:42:23.663199Z","end":"2026-04-17T00:42:23.784983Z","steps":["trace[2082540513] 'process raft request' (duration: 80.337944ms)","trace[2082540513] 'compare' (duration: 41.303828ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:42:23.785272Z","caller":"traceutil/trace.go:171","msg":"trace[1085673995] transaction","detail":"{read_only:false; response_revision:6388; number_of_response:1; }","duration":"121.951981ms","start":"2026-04-17T00:42:23.663285Z","end":"2026-04-17T00:42:23.785237Z","steps":["trace[1085673995] 'process raft request' (duration: 121.658113ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:42:23.785307Z","caller":"traceutil/trace.go:171","msg":"trace[1572046821] linearizableReadLoop","detail":"{readStateIndex:6621; appliedIndex:6616; }","duration":"116.764487ms","start":"2026-04-17T00:42:23.66852Z","end":"2026-04-17T00:42:23.785284Z","steps":["trace[1572046821] 'read index received' (duration: 6.531929ms)","trace[1572046821] 'applied index is now lower than readState.Index' (duration: 110.231298ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:42:23.785405Z","caller":"traceutil/trace.go:171","msg":"trace[2050673908] transaction","detail":"{read_only:false; response_revision:6389; number_of_response:1; }","duration":"121.849017ms","start":"2026-04-17T00:42:23.663515Z","end":"2026-04-17T00:42:23.785364Z","steps":["trace[2050673908] 'process raft request' (duration: 121.624621ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:42:23.785426Z","caller":"traceutil/trace.go:171","msg":"trace[1720378261] transaction","detail":"{read_only:false; response_revision:6390; number_of_response:1; }","duration":"121.135838ms","start":"2026-04-17T00:42:23.66428Z","end":"2026-04-17T00:42:23.785416Z","steps":["trace[1720378261] 'process raft request' (duration: 120.963013ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:23.785583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.045626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/keystone-api\" ","response":"range_response_count:1 size:674"} {"level":"info","ts":"2026-04-17T00:42:23.785626Z","caller":"traceutil/trace.go:171","msg":"trace[1002090568] range","detail":"{range_begin:/registry/services/endpoints/openstack/keystone-api; range_end:; response_count:1; response_revision:6390; }","duration":"117.119957ms","start":"2026-04-17T00:42:23.668497Z","end":"2026-04-17T00:42:23.785617Z","steps":["trace[1002090568] 'agreement among raft nodes before linearized reading' (duration: 116.947223ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:23.785736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.295095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-04-17T00:42:23.785736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.531834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-17T00:42:23.785754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.437608ms","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-04-17T00:42:23.785804Z","caller":"traceutil/trace.go:171","msg":"trace[1029172067] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6390; }","duration":"111.634016ms","start":"2026-04-17T00:42:23.674155Z","end":"2026-04-17T00:42:23.785789Z","steps":["trace[1029172067] 'agreement among raft nodes before linearized reading' (duration: 111.440431ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:42:23.785856Z","caller":"traceutil/trace.go:171","msg":"trace[534965155] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6390; }","duration":"112.569812ms","start":"2026-04-17T00:42:23.673262Z","end":"2026-04-17T00:42:23.785832Z","steps":["trace[534965155] 'agreement among raft nodes before linearized reading' (duration: 112.351486ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:42:23.785793Z","caller":"traceutil/trace.go:171","msg":"trace[1360528941] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6390; }","duration":"112.399078ms","start":"2026-04-17T00:42:23.67338Z","end":"2026-04-17T00:42:23.78578Z","steps":["trace[1360528941] 'agreement among raft nodes before linearized reading' (duration: 112.217813ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:23.785918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.598821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-9vq4w\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-17T00:42:23.786003Z","caller":"traceutil/trace.go:171","msg":"trace[932702451] range","detail":"{range_begin:/registry/pods/openstack/keepalived-9vq4w; range_end:; response_count:1; response_revision:6390; }","duration":"113.713364ms","start":"2026-04-17T00:42:23.67227Z","end":"2026-04-17T00:42:23.785983Z","steps":["trace[932702451] 'agreement among raft nodes before linearized reading' (duration: 113.428166ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:42:23.785971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.271827ms","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-17T00:42:23.786431Z","caller":"traceutil/trace.go:171","msg":"trace[461636387] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6390; }","duration":"115.568005ms","start":"2026-04-17T00:42:23.670606Z","end":"2026-04-17T00:42:23.786174Z","steps":["trace[461636387] 'agreement among raft nodes before linearized reading' (duration: 114.988639ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:42:23.938947Z","caller":"traceutil/trace.go:171","msg":"trace[184591100] transaction","detail":"{read_only:false; response_revision:6393; number_of_response:1; }","duration":"148.185273ms","start":"2026-04-17T00:42:23.790732Z","end":"2026-04-17T00:42:23.938917Z","steps":["trace[184591100] 'process raft request' (duration: 148.092641ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:42:23.938999Z","caller":"traceutil/trace.go:171","msg":"trace[193632067] transaction","detail":"{read_only:false; response_revision:6394; number_of_response:1; }","duration":"148.082921ms","start":"2026-04-17T00:42:23.790891Z","end":"2026-04-17T00:42:23.938974Z","steps":["trace[193632067] 'process raft request' (duration: 147.993278ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:42:23.939082Z","caller":"traceutil/trace.go:171","msg":"trace[1339994347] transaction","detail":"{read_only:false; response_revision:6392; number_of_response:1; }","duration":"148.281066ms","start":"2026-04-17T00:42:23.790735Z","end":"2026-04-17T00:42:23.939016Z","steps":["trace[1339994347] 'process raft request' (duration: 123.053381ms)","trace[1339994347] 'compare' (duration: 24.912946ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:46:21.023227Z","caller":"traceutil/trace.go:171","msg":"trace[1560604712] transaction","detail":"{read_only:false; response_revision:8174; number_of_response:1; }","duration":"287.159779ms","start":"2026-04-17T00:46:20.736041Z","end":"2026-04-17T00:46:21.023201Z","steps":["trace[1560604712] 'process raft request' (duration: 286.964533ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:46:21.024991Z","caller":"traceutil/trace.go:171","msg":"trace[26431817] transaction","detail":"{read_only:false; response_revision:8176; number_of_response:1; }","duration":"277.949743ms","start":"2026-04-17T00:46:20.747008Z","end":"2026-04-17T00:46:21.024958Z","steps":["trace[26431817] 'process raft request' (duration: 277.796279ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:46:21.025187Z","caller":"traceutil/trace.go:171","msg":"trace[41961825] transaction","detail":"{read_only:false; response_revision:8177; number_of_response:1; }","duration":"276.0262ms","start":"2026-04-17T00:46:20.749133Z","end":"2026-04-17T00:46:21.025159Z","steps":["trace[41961825] 'process raft request' (duration: 275.712581ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:46:21.025161Z","caller":"traceutil/trace.go:171","msg":"trace[1376068213] transaction","detail":"{read_only:false; response_revision:8175; number_of_response:1; }","duration":"278.226551ms","start":"2026-04-17T00:46:20.74691Z","end":"2026-04-17T00:46:21.025137Z","steps":["trace[1376068213] 'process raft request' (duration: 277.741648ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:46:33.745197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.203562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:46:33.745296Z","caller":"traceutil/trace.go:171","msg":"trace[1870022920] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8247; }","duration":"113.349586ms","start":"2026-04-17T00:46:33.631921Z","end":"2026-04-17T00:46:33.745271Z","steps":["trace[1870022920] 'range keys from in-memory index tree' (duration: 113.067598ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:46:34.686347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.467127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:46:34.686446Z","caller":"traceutil/trace.go:171","msg":"trace[1170792972] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:8248; }","duration":"187.621122ms","start":"2026-04-17T00:46:34.498795Z","end":"2026-04-17T00:46:34.686416Z","steps":["trace[1170792972] 'count revisions from in-memory index tree' (duration: 187.364264ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:46:41.55778Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6139} {"level":"info","ts":"2026-04-17T00:46:41.655038Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6139,"took":"94.656699ms","hash":3753941072,"current-db-size-bytes":58777600,"current-db-size":"59 MB","current-db-size-in-use-bytes":23019520,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-17T00:46:41.655106Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3753941072,"revision":6139,"compact-revision":3025} {"level":"warn","ts":"2026-04-17T00:47:05.721082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.149178ms","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-04-17T00:47:05.721239Z","caller":"traceutil/trace.go:171","msg":"trace[2094580796] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8473; }","duration":"187.404825ms","start":"2026-04-17T00:47:05.533802Z","end":"2026-04-17T00:47:05.721206Z","steps":["trace[2094580796] 'range keys from in-memory index tree' (duration: 186.87051ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:47:15.127351Z","caller":"traceutil/trace.go:171","msg":"trace[974628421] transaction","detail":"{read_only:false; response_revision:8563; number_of_response:1; }","duration":"149.772104ms","start":"2026-04-17T00:47:14.977546Z","end":"2026-04-17T00:47:15.127318Z","steps":["trace[974628421] 'process raft request' (duration: 149.554548ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:47:15.159246Z","caller":"traceutil/trace.go:171","msg":"trace[1953755633] transaction","detail":"{read_only:false; response_revision:8564; number_of_response:1; }","duration":"175.741673ms","start":"2026-04-17T00:47:14.983479Z","end":"2026-04-17T00:47:15.159221Z","steps":["trace[1953755633] 'process raft request' (duration: 175.607399ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:47:55.692226Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000242a.wal"} {"level":"info","ts":"2026-04-17T00:49:19.82184Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d98d5f2c752cc52d","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-17T00:49:19.828957Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-17T00:49:19.829102Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-17T00:51:41.565343Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8297} {"level":"info","ts":"2026-04-17T00:51:41.646375Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8297,"took":"79.083618ms","hash":149020737,"current-db-size-bytes":58777600,"current-db-size":"59 MB","current-db-size-in-use-bytes":24772608,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-17T00:51:41.646432Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":149020737,"revision":8297,"compact-revision":6139} {"level":"info","ts":"2026-04-17T00:54:52.718854Z","caller":"traceutil/trace.go:171","msg":"trace[1326227904] transaction","detail":"{read_only:false; response_revision:11683; number_of_response:1; }","duration":"339.949221ms","start":"2026-04-17T00:54:52.378786Z","end":"2026-04-17T00:54:52.718736Z","steps":["trace[1326227904] 'process raft request' (duration: 339.642603ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:52.719213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:54:52.378759Z","time spent":"340.191827ms","remote":"127.0.0.1:34676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T00:54:58.309042Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.252324025s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-17T00:54:58.363629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.369554033s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" ","response":"range_response_count:1 size:1857"} {"level":"info","ts":"2026-04-17T00:54:58.363716Z","caller":"traceutil/trace.go:171","msg":"trace[585669670] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0; range_end:; response_count:1; response_revision:11704; }","duration":"1.369706387s","start":"2026-04-17T00:54:56.993987Z","end":"2026-04-17T00:54:58.363693Z","steps":["trace[585669670] 'range keys from in-memory index tree' (duration: 1.369227343s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:58.363755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:54:56.993965Z","time spent":"1.36978103s","remote":"127.0.0.1:34576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":1,"response size":1881,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" "} {"level":"info","ts":"2026-04-17T00:54:58.364198Z","caller":"traceutil/trace.go:171","msg":"trace[408799586] transaction","detail":"{read_only:false; response_revision:11706; number_of_response:1; }","duration":"1.259208094s","start":"2026-04-17T00:54:57.104962Z","end":"2026-04-17T00:54:58.36417Z","steps":["trace[408799586] 'process raft request' (duration: 1.259103841s)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:54:58.364214Z","caller":"traceutil/trace.go:171","msg":"trace[1204189331] transaction","detail":"{read_only:false; response_revision:11705; number_of_response:1; }","duration":"1.307549755s","start":"2026-04-17T00:54:57.056618Z","end":"2026-04-17T00:54:58.364168Z","steps":["trace[1204189331] 'process raft request' (duration: 1.25359634s)","trace[1204189331] 'compare' (duration: 53.611466ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:54:58.364324Z","caller":"traceutil/trace.go:171","msg":"trace[356892349] transaction","detail":"{read_only:false; response_revision:11708; number_of_response:1; }","duration":"1.078243201s","start":"2026-04-17T00:54:57.286063Z","end":"2026-04-17T00:54:58.364307Z","steps":["trace[356892349] 'process raft request' (duration: 1.078175459s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:58.364364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:54:57.104944Z","time spent":"1.259309168s","remote":"127.0.0.1:34676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:54:58.36435Z","caller":"traceutil/trace.go:171","msg":"trace[1230434215] transaction","detail":"{read_only:false; response_revision:11707; number_of_response:1; }","duration":"1.256665854s","start":"2026-04-17T00:54:57.107641Z","end":"2026-04-17T00:54:58.364307Z","steps":["trace[1230434215] 'process raft request' (duration: 1.256500539s)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:54:58.364448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:54:57.286041Z","time spent":"1.078328964s","remote":"127.0.0.1:34676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T00:54:58.364464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:54:57.056601Z","time spent":"1.307749191s","remote":"127.0.0.1:34676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T00:54:58.364505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:54:57.107628Z","time spent":"1.256795408s","remote":"127.0.0.1:34676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:56:41.572131Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10686} {"level":"info","ts":"2026-04-17T00:56:41.650935Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10686,"took":"76.63103ms","hash":1908321237,"current-db-size-bytes":58777600,"current-db-size":"59 MB","current-db-size-in-use-bytes":20856832,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-17T00:56:41.651002Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1908321237,"revision":10686,"compact-revision":8297}