{"level":"warn","ts":"2026-05-26T13:48:23.934186Z","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-26T13:48:23.93435Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.210: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.210:2380","--initial-cluster=instance=https://199.204.45.210:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.210:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.210: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-26T13:48:23.934464Z","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-26T13:48:23.934482Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.210:2380"]} {"level":"info","ts":"2026-05-26T13:48:23.934512Z","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-26T13:48:23.935469Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"]} {"level":"info","ts":"2026-05-26T13:48:23.935582Z","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.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.210: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-26T13:48:23.940757Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.553146ms"} {"level":"info","ts":"2026-05-26T13:48:23.948573Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1cac722af8b2b8a6","cluster-id":"ba0a336ca61ee41d"} {"level":"info","ts":"2026-05-26T13:48:23.948691Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=()"} {"level":"info","ts":"2026-05-26T13:48:23.94872Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 0"} {"level":"info","ts":"2026-05-26T13:48:23.948739Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1cac722af8b2b8a6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-26T13:48:23.948751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became follower at term 1"} {"level":"info","ts":"2026-05-26T13:48:23.948799Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"} {"level":"warn","ts":"2026-05-26T13:48:23.955146Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-26T13:48:23.957011Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-26T13:48:23.958506Z","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-26T13:48:23.961763Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1cac722af8b2b8a6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-26T13:48:23.96223Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1cac722af8b2b8a6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-26T13:48:23.962417Z","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-26T13:48:23.962596Z","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-26T13:48:23.962618Z","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-26T13:48:23.965944Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 switched to configuration voters=(2066151857942870182)"} {"level":"info","ts":"2026-05-26T13:48:23.966298Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","added-peer-id":"1cac722af8b2b8a6","added-peer-peer-urls":["https://199.204.45.210:2380"]} {"level":"info","ts":"2026-05-26T13:48:23.968102Z","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-26T13:48:23.96824Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.210:2380"} {"level":"info","ts":"2026-05-26T13:48:23.968318Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.210:2380"} {"level":"info","ts":"2026-05-26T13:48:23.968609Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1cac722af8b2b8a6","initial-advertise-peer-urls":["https://199.204.45.210:2380"],"listen-peer-urls":["https://199.204.45.210:2380"],"advertise-client-urls":["https://199.204.45.210:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.210:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-26T13:48:23.968653Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-26T13:48:24.949203Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 is starting a new election at term 1"} {"level":"info","ts":"2026-05-26T13:48:24.949286Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-26T13:48:24.949326Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgPreVoteResp from 1cac722af8b2b8a6 at term 1"} {"level":"info","ts":"2026-05-26T13:48:24.949345Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became candidate at term 2"} {"level":"info","ts":"2026-05-26T13:48:24.949352Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 received MsgVoteResp from 1cac722af8b2b8a6 at term 2"} {"level":"info","ts":"2026-05-26T13:48:24.949365Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1cac722af8b2b8a6 became leader at term 2"} {"level":"info","ts":"2026-05-26T13:48:24.94938Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1cac722af8b2b8a6 elected leader 1cac722af8b2b8a6 at term 2"} {"level":"info","ts":"2026-05-26T13:48:24.950937Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T13:48:24.953434Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-26T13:48:24.953422Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1cac722af8b2b8a6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.210:2379]}","request-path":"/0/members/1cac722af8b2b8a6/attributes","cluster-id":"ba0a336ca61ee41d","publish-timeout":"7s"} {"level":"info","ts":"2026-05-26T13:48:24.953572Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-26T13:48:24.953736Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ba0a336ca61ee41d","local-member-id":"1cac722af8b2b8a6","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T13:48:24.953868Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T13:48:24.953856Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-26T13:48:24.953933Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T13:48:24.953957Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-26T13:48:24.956405Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-26T13:48:24.957046Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.210:2379"} {"level":"info","ts":"2026-05-26T13:48:40.810564Z","caller":"traceutil/trace.go:171","msg":"trace[934216272] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"129.346084ms","start":"2026-05-26T13:48:40.681183Z","end":"2026-05-26T13:48:40.810529Z","steps":["trace[934216272] 'process raft request' (duration: 129.141678ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:48:41.05717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.269974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-26T13:48:41.057291Z","caller":"traceutil/trace.go:171","msg":"trace[1556252256] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:415; }","duration":"158.518732ms","start":"2026-05-26T13:48:40.898748Z","end":"2026-05-26T13:48:41.057267Z","steps":["trace[1556252256] 'range keys from in-memory index tree' (duration: 158.055589ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:49:11.611645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.77932ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-26T13:49:11.611883Z","caller":"traceutil/trace.go:171","msg":"trace[299990768] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"173.794063ms","start":"2026-05-26T13:49:11.438057Z","end":"2026-05-26T13:49:11.611851Z","steps":["trace[299990768] 'process raft request' (duration: 68.239532ms)","trace[299990768] 'compare' (duration: 104.528133ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T13:49:12.203133Z","caller":"traceutil/trace.go:171","msg":"trace[973149830] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"157.885535ms","start":"2026-05-26T13:49:12.04521Z","end":"2026-05-26T13:49:12.203095Z","steps":["trace[973149830] 'process raft request' (duration: 153.268118ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:49:12.669658Z","caller":"traceutil/trace.go:171","msg":"trace[300789888] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"413.039093ms","start":"2026-05-26T13:49:12.256548Z","end":"2026-05-26T13:49:12.669587Z","steps":["trace[300789888] 'process raft request' (duration: 403.653824ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:49:12.670011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:49:12.256521Z","time spent":"413.294131ms","remote":"127.0.0.1:43794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T13:50:57.933799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.240716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-26T13:50:57.933946Z","caller":"traceutil/trace.go:171","msg":"trace[505407620] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1936; }","duration":"101.41005ms","start":"2026-05-26T13:50:57.832482Z","end":"2026-05-26T13:50:57.933892Z","steps":["trace[505407620] 'range keys from in-memory index tree' (duration: 101.04452ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:50:57.934095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.03854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-26T13:50:57.934209Z","caller":"traceutil/trace.go:171","msg":"trace[258554520] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1936; }","duration":"164.208365ms","start":"2026-05-26T13:50:57.769975Z","end":"2026-05-26T13:50:57.934183Z","steps":["trace[258554520] 'range keys from in-memory index tree' (duration: 163.738042ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:51:40.091238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.988276ms","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-05-26T13:51:40.091356Z","caller":"traceutil/trace.go:171","msg":"trace[2145170059] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2216; }","duration":"225.15246ms","start":"2026-05-26T13:51:39.866181Z","end":"2026-05-26T13:51:40.091333Z","steps":["trace[2145170059] 'range keys from in-memory index tree' (duration: 224.704147ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:51:41.874508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.709292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T13:51:41.874612Z","caller":"traceutil/trace.go:171","msg":"trace[892684971] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:2226; }","duration":"147.907387ms","start":"2026-05-26T13:51:41.726683Z","end":"2026-05-26T13:51:41.874591Z","steps":["trace[892684971] 'count revisions from in-memory index tree' (duration: 147.585348ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:51:52.006822Z","caller":"traceutil/trace.go:171","msg":"trace[888688700] transaction","detail":"{read_only:false; response_revision:2280; number_of_response:1; }","duration":"239.469242ms","start":"2026-05-26T13:51:51.767309Z","end":"2026-05-26T13:51:52.006778Z","steps":["trace[888688700] 'process raft request' (duration: 239.113832ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:52:47.097708Z","caller":"traceutil/trace.go:171","msg":"trace[320684164] transaction","detail":"{read_only:false; response_revision:2745; number_of_response:1; }","duration":"184.382273ms","start":"2026-05-26T13:52:46.913286Z","end":"2026-05-26T13:52:47.097668Z","steps":["trace[320684164] 'process raft request' (duration: 184.135876ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:53:21.026221Z","caller":"traceutil/trace.go:171","msg":"trace[537513031] transaction","detail":"{read_only:false; response_revision:2951; number_of_response:1; }","duration":"167.465097ms","start":"2026-05-26T13:53:20.858724Z","end":"2026-05-26T13:53:21.026189Z","steps":["trace[537513031] 'process raft request' (duration: 167.285512ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:53:21.034397Z","caller":"traceutil/trace.go:171","msg":"trace[968264595] linearizableReadLoop","detail":"{readStateIndex:3063; appliedIndex:3061; }","duration":"107.586101ms","start":"2026-05-26T13:53:20.926772Z","end":"2026-05-26T13:53:21.034358Z","steps":["trace[968264595] 'read index received' (duration: 99.238493ms)","trace[968264595] 'applied index is now lower than readState.Index' (duration: 8.346368ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T13:53:21.034624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.823227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T13:53:21.034663Z","caller":"traceutil/trace.go:171","msg":"trace[2100030445] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:2952; }","duration":"107.93815ms","start":"2026-05-26T13:53:20.926713Z","end":"2026-05-26T13:53:21.034651Z","steps":["trace[2100030445] 'agreement among raft nodes before linearized reading' (duration: 107.795136ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:53:21.034872Z","caller":"traceutil/trace.go:171","msg":"trace[2082879742] transaction","detail":"{read_only:false; response_revision:2952; number_of_response:1; }","duration":"174.701595ms","start":"2026-05-26T13:53:20.860122Z","end":"2026-05-26T13:53:21.034824Z","steps":["trace[2082879742] 'process raft request' (duration: 174.061757ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:53:21.518934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.198938ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T13:53:21.519263Z","caller":"traceutil/trace.go:171","msg":"trace[1896481159] transaction","detail":"{read_only:false; response_revision:2953; number_of_response:1; }","duration":"270.107642ms","start":"2026-05-26T13:53:21.249133Z","end":"2026-05-26T13:53:21.51924Z","steps":["trace[1896481159] 'process raft request' (duration: 109.122073ms)","trace[1896481159] 'compare' (duration: 159.744115ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T13:53:21.519806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.2411ms","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-05-26T13:53:21.519763Z","caller":"traceutil/trace.go:171","msg":"trace[58983654] linearizableReadLoop","detail":"{readStateIndex:3064; appliedIndex:3063; }","duration":"241.792688ms","start":"2026-05-26T13:53:21.27756Z","end":"2026-05-26T13:53:21.519352Z","steps":["trace[58983654] 'read index received' (duration: 80.778768ms)","trace[58983654] 'applied index is now lower than readState.Index' (duration: 161.00916ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T13:53:21.519856Z","caller":"traceutil/trace.go:171","msg":"trace[1999195883] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2954; }","duration":"242.340753ms","start":"2026-05-26T13:53:21.277502Z","end":"2026-05-26T13:53:21.519843Z","steps":["trace[1999195883] 'agreement among raft nodes before linearized reading' (duration: 242.169098ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:53:21.519992Z","caller":"traceutil/trace.go:171","msg":"trace[1673627135] transaction","detail":"{read_only:false; response_revision:2954; number_of_response:1; }","duration":"233.779859ms","start":"2026-05-26T13:53:21.286186Z","end":"2026-05-26T13:53:21.519966Z","steps":["trace[1673627135] 'process raft request' (duration: 232.859604ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:53:21.520265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.472613ms","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-26T13:53:21.520311Z","caller":"traceutil/trace.go:171","msg":"trace[1574633044] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2955; }","duration":"146.572355ms","start":"2026-05-26T13:53:21.373728Z","end":"2026-05-26T13:53:21.5203Z","steps":["trace[1574633044] 'agreement among raft nodes before linearized reading' (duration: 146.449312ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:53:21.520564Z","caller":"traceutil/trace.go:171","msg":"trace[1584589839] transaction","detail":"{read_only:false; response_revision:2955; number_of_response:1; }","duration":"163.001934ms","start":"2026-05-26T13:53:21.357551Z","end":"2026-05-26T13:53:21.520553Z","steps":["trace[1584589839] 'process raft request' (duration: 162.553682ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:55:58.33173Z","caller":"traceutil/trace.go:171","msg":"trace[246833127] transaction","detail":"{read_only:false; response_revision:3977; number_of_response:1; }","duration":"146.868846ms","start":"2026-05-26T13:55:58.184829Z","end":"2026-05-26T13:55:58.331698Z","steps":["trace[246833127] 'process raft request' (duration: 146.6345ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:55:58.332978Z","caller":"traceutil/trace.go:171","msg":"trace[1565314015] transaction","detail":"{read_only:false; response_revision:3978; number_of_response:1; }","duration":"144.139712ms","start":"2026-05-26T13:55:58.188808Z","end":"2026-05-26T13:55:58.332948Z","steps":["trace[1565314015] 'process raft request' (duration: 143.517725ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:55:58.333588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.840318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.210\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-26T13:55:58.333637Z","caller":"traceutil/trace.go:171","msg":"trace[1820235947] range","detail":"{range_begin:/registry/masterleases/199.204.45.210; range_end:; response_count:1; response_revision:3979; }","duration":"141.933561ms","start":"2026-05-26T13:55:58.191694Z","end":"2026-05-26T13:55:58.333627Z","steps":["trace[1820235947] 'agreement among raft nodes before linearized reading' (duration: 141.766346ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:55:58.333415Z","caller":"traceutil/trace.go:171","msg":"trace[345769652] linearizableReadLoop","detail":"{readStateIndex:4127; appliedIndex:4125; }","duration":"141.623252ms","start":"2026-05-26T13:55:58.191727Z","end":"2026-05-26T13:55:58.33335Z","steps":["trace[345769652] 'read index received' (duration: 139.781031ms)","trace[345769652] 'applied index is now lower than readState.Index' (duration: 1.840271ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T13:57:30.172648Z","caller":"traceutil/trace.go:171","msg":"trace[1441369554] linearizableReadLoop","detail":"{readStateIndex:5263; appliedIndex:5262; }","duration":"143.184768ms","start":"2026-05-26T13:57:30.029425Z","end":"2026-05-26T13:57:30.17261Z","steps":["trace[1441369554] 'read index received' (duration: 143.007223ms)","trace[1441369554] 'applied index is now lower than readState.Index' (duration: 174.555µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T13:57:30.172837Z","caller":"traceutil/trace.go:171","msg":"trace[988067325] transaction","detail":"{read_only:false; response_revision:5068; number_of_response:1; }","duration":"147.61529ms","start":"2026-05-26T13:57:30.025208Z","end":"2026-05-26T13:57:30.172823Z","steps":["trace[988067325] 'process raft request' (duration: 147.119506ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:57:30.174107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.658848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:50 size:2209851"} {"level":"info","ts":"2026-05-26T13:57:30.174244Z","caller":"traceutil/trace.go:171","msg":"trace[584554126] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:50; response_revision:5068; }","duration":"144.855225ms","start":"2026-05-26T13:57:30.029365Z","end":"2026-05-26T13:57:30.174221Z","steps":["trace[584554126] 'agreement among raft nodes before linearized reading' (duration: 143.621511ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:57:30.378889Z","caller":"traceutil/trace.go:171","msg":"trace[1366513689] linearizableReadLoop","detail":"{readStateIndex:5264; appliedIndex:5263; }","duration":"206.084793ms","start":"2026-05-26T13:57:30.172773Z","end":"2026-05-26T13:57:30.378857Z","steps":["trace[1366513689] 'read index received' (duration: 191.385267ms)","trace[1366513689] 'applied index is now lower than readState.Index' (duration: 14.697466ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T13:57:30.379077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.838442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T13:57:30.378924Z","caller":"traceutil/trace.go:171","msg":"trace[1495892272] transaction","detail":"{read_only:false; response_revision:5069; number_of_response:1; }","duration":"299.057897ms","start":"2026-05-26T13:57:30.079844Z","end":"2026-05-26T13:57:30.378902Z","steps":["trace[1495892272] 'process raft request' (duration: 284.228868ms)","trace[1495892272] 'compare' (duration: 14.632673ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T13:57:30.379115Z","caller":"traceutil/trace.go:171","msg":"trace[1404091277] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:5069; }","duration":"244.957164ms","start":"2026-05-26T13:57:30.134145Z","end":"2026-05-26T13:57:30.379103Z","steps":["trace[1404091277] 'agreement among raft nodes before linearized reading' (duration: 244.859972ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:57:30.379299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.168033ms","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-05-26T13:57:30.379415Z","caller":"traceutil/trace.go:171","msg":"trace[942234186] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5069; }","duration":"269.302766ms","start":"2026-05-26T13:57:30.110065Z","end":"2026-05-26T13:57:30.379368Z","steps":["trace[942234186] 'agreement among raft nodes before linearized reading' (duration: 269.060909ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:57:30.454578Z","caller":"traceutil/trace.go:171","msg":"trace[1154280203] transaction","detail":"{read_only:false; response_revision:5070; number_of_response:1; }","duration":"276.904475ms","start":"2026-05-26T13:57:30.177632Z","end":"2026-05-26T13:57:30.454536Z","steps":["trace[1154280203] 'process raft request' (duration: 276.672889ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:57:30.45477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.174611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T13:57:30.454856Z","caller":"traceutil/trace.go:171","msg":"trace[1640913325] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:5071; }","duration":"150.339026ms","start":"2026-05-26T13:57:30.304497Z","end":"2026-05-26T13:57:30.454836Z","steps":["trace[1640913325] 'agreement among raft nodes before linearized reading' (duration: 150.1301ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:57:30.45486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.408974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-05-26T13:57:30.454859Z","caller":"traceutil/trace.go:171","msg":"trace[2058573713] transaction","detail":"{read_only:false; response_revision:5071; number_of_response:1; }","duration":"207.371158ms","start":"2026-05-26T13:57:30.247432Z","end":"2026-05-26T13:57:30.454803Z","steps":["trace[2058573713] 'process raft request' (duration: 207.065219ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:57:30.454969Z","caller":"traceutil/trace.go:171","msg":"trace[489021634] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5071; }","duration":"209.563479ms","start":"2026-05-26T13:57:30.245381Z","end":"2026-05-26T13:57:30.454944Z","steps":["trace[489021634] 'agreement among raft nodes before linearized reading' (duration: 209.25632ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:57:30.454999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.505902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:11454"} {"level":"info","ts":"2026-05-26T13:57:30.455041Z","caller":"traceutil/trace.go:171","msg":"trace[1498602765] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5071; }","duration":"265.605324ms","start":"2026-05-26T13:57:30.189425Z","end":"2026-05-26T13:57:30.455031Z","steps":["trace[1498602765] 'agreement among raft nodes before linearized reading' (duration: 265.44292ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:57:30.455019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.343997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-05-26T13:57:30.455084Z","caller":"traceutil/trace.go:171","msg":"trace[1940529952] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:5071; }","duration":"240.460491ms","start":"2026-05-26T13:57:30.214605Z","end":"2026-05-26T13:57:30.455065Z","steps":["trace[1940529952] 'agreement among raft nodes before linearized reading' (duration: 240.223934ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:57:30.606797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.298816ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T13:57:30.607014Z","caller":"traceutil/trace.go:171","msg":"trace[178536161] linearizableReadLoop","detail":"{readStateIndex:5268; appliedIndex:5266; }","duration":"152.391013ms","start":"2026-05-26T13:57:30.454609Z","end":"2026-05-26T13:57:30.607Z","steps":["trace[178536161] 'read index received' (duration: 51.804939ms)","trace[178536161] 'applied index is now lower than readState.Index' (duration: 100.585213ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T13:57:30.607089Z","caller":"traceutil/trace.go:171","msg":"trace[379074731] transaction","detail":"{read_only:false; response_revision:5072; number_of_response:1; }","duration":"223.439862ms","start":"2026-05-26T13:57:30.383639Z","end":"2026-05-26T13:57:30.607079Z","steps":["trace[379074731] 'process raft request' (duration: 122.749255ms)","trace[379074731] 'compare' (duration: 99.764911ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T13:57:30.607341Z","caller":"traceutil/trace.go:171","msg":"trace[152728135] transaction","detail":"{read_only:false; response_revision:5073; number_of_response:1; }","duration":"206.731961ms","start":"2026-05-26T13:57:30.400602Z","end":"2026-05-26T13:57:30.607334Z","steps":["trace[152728135] 'process raft request' (duration: 206.296729ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:57:30.607525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.163216ms","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-05-26T13:57:30.607556Z","caller":"traceutil/trace.go:171","msg":"trace[1881741750] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5073; }","duration":"193.198418ms","start":"2026-05-26T13:57:30.41435Z","end":"2026-05-26T13:57:30.607548Z","steps":["trace[1881741750] 'agreement among raft nodes before linearized reading' (duration: 193.097605ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:57:30.615997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.528916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-bf1594d7-b69f-451c-878e-4671172f3243\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-05-26T13:57:30.616083Z","caller":"traceutil/trace.go:171","msg":"trace[825866076] range","detail":"{range_begin:/registry/persistentvolumes/pvc-bf1594d7-b69f-451c-878e-4671172f3243; range_end:; response_count:1; response_revision:5074; }","duration":"156.68093ms","start":"2026-05-26T13:57:30.459384Z","end":"2026-05-26T13:57:30.616065Z","steps":["trace[825866076] 'agreement among raft nodes before linearized reading' (duration: 156.405383ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:57:30.616958Z","caller":"traceutil/trace.go:171","msg":"trace[1267069580] transaction","detail":"{read_only:false; response_revision:5074; number_of_response:1; }","duration":"148.559076ms","start":"2026-05-26T13:57:30.468375Z","end":"2026-05-26T13:57:30.616934Z","steps":["trace[1267069580] 'process raft request' (duration: 147.268291ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:57:30.617367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.113903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-05-26T13:57:30.617472Z","caller":"traceutil/trace.go:171","msg":"trace[2050366409] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5074; }","duration":"132.276948ms","start":"2026-05-26T13:57:30.48517Z","end":"2026-05-26T13:57:30.617447Z","steps":["trace[2050366409] 'agreement among raft nodes before linearized reading' (duration: 131.99172ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:57:31.517158Z","caller":"traceutil/trace.go:171","msg":"trace[1920269836] transaction","detail":"{read_only:false; response_revision:5091; number_of_response:1; }","duration":"112.757059ms","start":"2026-05-26T13:57:31.404359Z","end":"2026-05-26T13:57:31.517116Z","steps":["trace[1920269836] 'process raft request' (duration: 33.494264ms)","trace[1920269836] 'compare' (duration: 79.06031ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T13:57:31.559747Z","caller":"traceutil/trace.go:171","msg":"trace[2101748610] transaction","detail":"{read_only:false; response_revision:5093; number_of_response:1; }","duration":"150.933832ms","start":"2026-05-26T13:57:31.408775Z","end":"2026-05-26T13:57:31.559709Z","steps":["trace[2101748610] 'process raft request' (duration: 150.829599ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:57:31.559796Z","caller":"traceutil/trace.go:171","msg":"trace[578187851] transaction","detail":"{read_only:false; response_revision:5092; number_of_response:1; }","duration":"152.916786ms","start":"2026-05-26T13:57:31.406852Z","end":"2026-05-26T13:57:31.559769Z","steps":["trace[578187851] 'process raft request' (duration: 152.545966ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:57:48.11243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.13462ms","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-26T13:57:48.112548Z","caller":"traceutil/trace.go:171","msg":"trace[124068687] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5473; }","duration":"113.322755ms","start":"2026-05-26T13:57:47.999204Z","end":"2026-05-26T13:57:48.112526Z","steps":["trace[124068687] 'range keys from in-memory index tree' (duration: 112.353168ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:57:48.112571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.369701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-2b9xk\" ","response":"range_response_count:1 size:7818"} {"level":"info","ts":"2026-05-26T13:57:48.11267Z","caller":"traceutil/trace.go:171","msg":"trace[1732790100] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-2b9xk; range_end:; response_count:1; response_revision:5473; }","duration":"103.531865ms","start":"2026-05-26T13:57:48.009112Z","end":"2026-05-26T13:57:48.112644Z","steps":["trace[1732790100] 'range keys from in-memory index tree' (duration: 102.465195ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:57:48.764071Z","caller":"traceutil/trace.go:171","msg":"trace[629868812] linearizableReadLoop","detail":"{readStateIndex:5690; appliedIndex:5689; }","duration":"161.536864ms","start":"2026-05-26T13:57:48.602511Z","end":"2026-05-26T13:57:48.764048Z","steps":["trace[629868812] 'read index received' (duration: 161.370419ms)","trace[629868812] 'applied index is now lower than readState.Index' (duration: 165.315µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T13:57:48.764167Z","caller":"traceutil/trace.go:171","msg":"trace[1809627849] transaction","detail":"{read_only:false; response_revision:5482; number_of_response:1; }","duration":"225.530669ms","start":"2026-05-26T13:57:48.538608Z","end":"2026-05-26T13:57:48.764139Z","steps":["trace[1809627849] 'process raft request' (duration: 225.265181ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:57:48.764262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.73987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T13:57:48.764355Z","caller":"traceutil/trace.go:171","msg":"trace[1864450] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5482; }","duration":"161.910345ms","start":"2026-05-26T13:57:48.602426Z","end":"2026-05-26T13:57:48.764336Z","steps":["trace[1864450] 'agreement among raft nodes before linearized reading' (duration: 161.74096ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:57:48.785232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.642406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T13:57:48.785317Z","caller":"traceutil/trace.go:171","msg":"trace[601872221] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:5483; }","duration":"120.78046ms","start":"2026-05-26T13:57:48.664521Z","end":"2026-05-26T13:57:48.785301Z","steps":["trace[601872221] 'agreement among raft nodes before linearized reading' (duration: 120.616635ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:57:56.988718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.500047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-566bb665-3083-4b90-8b53-76148025b585\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-05-26T13:57:56.988832Z","caller":"traceutil/trace.go:171","msg":"trace[2132673171] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-566bb665-3083-4b90-8b53-76148025b585; range_end:; response_count:1; response_revision:5653; }","duration":"201.669311ms","start":"2026-05-26T13:57:56.787135Z","end":"2026-05-26T13:57:56.988804Z","steps":["trace[2132673171] 'range keys from in-memory index tree' (duration: 201.312372ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:57:57.001045Z","caller":"traceutil/trace.go:171","msg":"trace[1754232001] transaction","detail":"{read_only:false; response_revision:5654; number_of_response:1; }","duration":"206.239787ms","start":"2026-05-26T13:57:56.794778Z","end":"2026-05-26T13:57:57.001018Z","steps":["trace[1754232001] 'process raft request' (duration: 206.057132ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:57:57.255432Z","caller":"traceutil/trace.go:171","msg":"trace[2069373485] transaction","detail":"{read_only:false; response_revision:5655; number_of_response:1; }","duration":"442.666575ms","start":"2026-05-26T13:57:56.812727Z","end":"2026-05-26T13:57:57.255393Z","steps":["trace[2069373485] 'process raft request' (duration: 442.420418ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:57:57.255595Z","caller":"traceutil/trace.go:171","msg":"trace[1541918352] linearizableReadLoop","detail":"{readStateIndex:5868; appliedIndex:5865; }","duration":"394.430445ms","start":"2026-05-26T13:57:56.861147Z","end":"2026-05-26T13:57:57.255577Z","steps":["trace[1541918352] 'read index received' (duration: 139.690132ms)","trace[1541918352] 'applied index is now lower than readState.Index' (duration: 254.739353ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T13:57:57.255623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:57:56.812695Z","time spent":"442.805459ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T13:57:57.255828Z","caller":"traceutil/trace.go:171","msg":"trace[1165551556] transaction","detail":"{read_only:false; response_revision:5656; number_of_response:1; }","duration":"397.437648ms","start":"2026-05-26T13:57:56.858376Z","end":"2026-05-26T13:57:57.255814Z","steps":["trace[1165551556] 'process raft request' (duration: 396.938554ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:57:57.255901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:57:56.858345Z","time spent":"397.50925ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T13:57:57.256022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.635187ms","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-05-26T13:57:57.256048Z","caller":"traceutil/trace.go:171","msg":"trace[343825155] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5656; }","duration":"132.706209ms","start":"2026-05-26T13:57:57.123334Z","end":"2026-05-26T13:57:57.256041Z","steps":["trace[343825155] 'agreement among raft nodes before linearized reading' (duration: 132.590066ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:57:57.256037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.719893ms","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-05-26T13:57:57.256093Z","caller":"traceutil/trace.go:171","msg":"trace[1796656500] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5656; }","duration":"390.833626ms","start":"2026-05-26T13:57:56.865245Z","end":"2026-05-26T13:57:57.256079Z","steps":["trace[1796656500] 'agreement among raft nodes before linearized reading' (duration: 390.652891ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:57:57.256125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:57:56.865229Z","time spent":"390.889987ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-26T13:57:57.256126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.752896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-05-26T13:57:57.256199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.056022ms","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-05-26T13:57:57.256195Z","caller":"traceutil/trace.go:171","msg":"trace[1467744325] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5656; }","duration":"130.874989ms","start":"2026-05-26T13:57:57.125301Z","end":"2026-05-26T13:57:57.256176Z","steps":["trace[1467744325] 'agreement among raft nodes before linearized reading' (duration: 130.691834ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:57:57.256236Z","caller":"traceutil/trace.go:171","msg":"trace[793911704] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5656; }","duration":"395.132524ms","start":"2026-05-26T13:57:56.861093Z","end":"2026-05-26T13:57:57.256225Z","steps":["trace[793911704] 'agreement among raft nodes before linearized reading' (duration: 395.024731ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:57:57.256216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.431083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-pushgateway-7b8659c68b-sx2gh\" ","response":"range_response_count:1 size:4040"} {"level":"warn","ts":"2026-05-26T13:57:57.256267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:57:56.861071Z","time spent":"395.189496ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-26T13:57:57.25632Z","caller":"traceutil/trace.go:171","msg":"trace[1159120281] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-pushgateway-7b8659c68b-sx2gh; range_end:; response_count:1; response_revision:5656; }","duration":"152.603888ms","start":"2026-05-26T13:57:57.103688Z","end":"2026-05-26T13:57:57.256292Z","steps":["trace[1159120281] 'agreement among raft nodes before linearized reading' (duration: 152.288359ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:57:57.256329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.112346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-05-26T13:57:57.256356Z","caller":"traceutil/trace.go:171","msg":"trace[670732490] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5656; }","duration":"143.190029ms","start":"2026-05-26T13:57:57.113158Z","end":"2026-05-26T13:57:57.256348Z","steps":["trace[670732490] 'agreement among raft nodes before linearized reading' (duration: 143.057315ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:57:57.256368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.830381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8j77d\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-05-26T13:57:57.256399Z","caller":"traceutil/trace.go:171","msg":"trace[82435570] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8j77d; range_end:; response_count:1; response_revision:5656; }","duration":"388.901093ms","start":"2026-05-26T13:57:56.867491Z","end":"2026-05-26T13:57:57.256392Z","steps":["trace[82435570] 'agreement among raft nodes before linearized reading' (duration: 388.81024ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:57:57.256433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T13:57:56.86747Z","time spent":"388.944584ms","remote":"127.0.0.1:43444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6553,"request content":"key:\"/registry/pods/openstack/keepalived-8j77d\" "} {"level":"info","ts":"2026-05-26T13:57:57.522398Z","caller":"traceutil/trace.go:171","msg":"trace[2037422643] linearizableReadLoop","detail":"{readStateIndex:5875; appliedIndex:5873; }","duration":"134.18075ms","start":"2026-05-26T13:57:57.388183Z","end":"2026-05-26T13:57:57.522363Z","steps":["trace[2037422643] 'read index received' (duration: 73.006063ms)","trace[2037422643] 'applied index is now lower than readState.Index' (duration: 61.173187ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T13:57:57.522539Z","caller":"traceutil/trace.go:171","msg":"trace[1860432690] transaction","detail":"{read_only:false; response_revision:5663; number_of_response:1; }","duration":"134.54952ms","start":"2026-05-26T13:57:57.387958Z","end":"2026-05-26T13:57:57.522507Z","steps":["trace[1860432690] 'process raft request' (duration: 122.478327ms)","trace[1860432690] 'compare' (duration: 11.698982ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T13:57:57.522645Z","caller":"traceutil/trace.go:171","msg":"trace[755721599] transaction","detail":"{read_only:false; response_revision:5664; number_of_response:1; }","duration":"133.79153ms","start":"2026-05-26T13:57:57.38882Z","end":"2026-05-26T13:57:57.522612Z","steps":["trace[755721599] 'process raft request' (duration: 133.463331ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:57:57.522723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.503758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" ","response":"range_response_count:1 size:4792"} {"level":"info","ts":"2026-05-26T13:57:57.522783Z","caller":"traceutil/trace.go:171","msg":"trace[229622727] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls; range_end:; response_count:1; response_revision:5664; }","duration":"134.623432ms","start":"2026-05-26T13:57:57.38814Z","end":"2026-05-26T13:57:57.522764Z","steps":["trace[229622727] 'agreement among raft nodes before linearized reading' (duration: 134.390615ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:57:59.348345Z","caller":"traceutil/trace.go:171","msg":"trace[122721498] transaction","detail":"{read_only:false; response_revision:5691; number_of_response:1; }","duration":"158.966143ms","start":"2026-05-26T13:57:59.189344Z","end":"2026-05-26T13:57:59.34831Z","steps":["trace[122721498] 'process raft request' (duration: 154.041848ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:57:59.348361Z","caller":"traceutil/trace.go:171","msg":"trace[1884121212] transaction","detail":"{read_only:false; response_revision:5692; number_of_response:1; }","duration":"158.971174ms","start":"2026-05-26T13:57:59.189358Z","end":"2026-05-26T13:57:59.34833Z","steps":["trace[1884121212] 'process raft request' (duration: 158.859151ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:57:59.348854Z","caller":"traceutil/trace.go:171","msg":"trace[1567700224] transaction","detail":"{read_only:false; response_revision:5693; number_of_response:1; }","duration":"159.22815ms","start":"2026-05-26T13:57:59.189595Z","end":"2026-05-26T13:57:59.348823Z","steps":["trace[1567700224] 'process raft request' (duration: 158.685605ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:57:59.349338Z","caller":"traceutil/trace.go:171","msg":"trace[1132679229] transaction","detail":"{read_only:false; response_revision:5694; number_of_response:1; }","duration":"157.490333ms","start":"2026-05-26T13:57:59.191828Z","end":"2026-05-26T13:57:59.349318Z","steps":["trace[1132679229] 'process raft request' (duration: 156.730992ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:57:59.349641Z","caller":"traceutil/trace.go:171","msg":"trace[1635437065] transaction","detail":"{read_only:false; response_revision:5695; number_of_response:1; }","duration":"157.485812ms","start":"2026-05-26T13:57:59.192139Z","end":"2026-05-26T13:57:59.349624Z","steps":["trace[1635437065] 'process raft request' (duration: 157.02629ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:58:08.341897Z","caller":"traceutil/trace.go:171","msg":"trace[1036164828] linearizableReadLoop","detail":"{readStateIndex:6017; appliedIndex:6016; }","duration":"103.252807ms","start":"2026-05-26T13:58:08.238613Z","end":"2026-05-26T13:58:08.341866Z","steps":["trace[1036164828] 'read index received' (duration: 95.503664ms)","trace[1036164828] 'applied index is now lower than readState.Index' (duration: 7.748213ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T13:58:08.342002Z","caller":"traceutil/trace.go:171","msg":"trace[133641975] transaction","detail":"{read_only:false; response_revision:5801; number_of_response:1; }","duration":"104.575204ms","start":"2026-05-26T13:58:08.237386Z","end":"2026-05-26T13:58:08.341962Z","steps":["trace[133641975] 'process raft request' (duration: 96.757328ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T13:58:08.342205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.536255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-05-26T13:58:08.342319Z","caller":"traceutil/trace.go:171","msg":"trace[1403112207] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:5801; }","duration":"103.71801ms","start":"2026-05-26T13:58:08.238579Z","end":"2026-05-26T13:58:08.342298Z","steps":["trace[1403112207] 'agreement among raft nodes before linearized reading' (duration: 103.443492ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T13:58:24.979925Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2973} {"level":"info","ts":"2026-05-26T13:58:25.059768Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2973,"took":"77.864437ms","hash":2278695121,"current-db-size-bytes":56995840,"current-db-size":"57 MB","current-db-size-in-use-bytes":32411648,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-05-26T13:58:25.059905Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2278695121,"revision":2973,"compact-revision":-1} {"level":"info","ts":"2026-05-26T14:01:37.090722Z","caller":"traceutil/trace.go:171","msg":"trace[723702659] linearizableReadLoop","detail":"{readStateIndex:7487; appliedIndex:7486; }","duration":"387.370053ms","start":"2026-05-26T14:01:36.703327Z","end":"2026-05-26T14:01:37.090697Z","steps":["trace[723702659] 'read index received' (duration: 387.187868ms)","trace[723702659] 'applied index is now lower than readState.Index' (duration: 181.145µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T14:01:37.090884Z","caller":"traceutil/trace.go:171","msg":"trace[810478022] transaction","detail":"{read_only:false; response_revision:7223; number_of_response:1; }","duration":"390.312895ms","start":"2026-05-26T14:01:36.700517Z","end":"2026-05-26T14:01:37.09083Z","steps":["trace[810478022] 'process raft request' (duration: 390.008447ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:01:37.091009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.656902ms","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-05-26T14:01:37.091046Z","caller":"traceutil/trace.go:171","msg":"trace[545782369] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7223; }","duration":"387.750354ms","start":"2026-05-26T14:01:36.703289Z","end":"2026-05-26T14:01:37.091039Z","steps":["trace[545782369] 'agreement among raft nodes before linearized reading' (duration: 387.537378ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:01:37.091076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:01:36.703272Z","time spent":"387.796766ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-26T14:01:37.091304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:01:36.700484Z","time spent":"390.604633ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T14:01:37.092167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.713851ms","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-26T14:01:37.092277Z","caller":"traceutil/trace.go:171","msg":"trace[359451383] transaction","detail":"{read_only:false; response_revision:7224; number_of_response:1; }","duration":"179.824089ms","start":"2026-05-26T14:01:36.91243Z","end":"2026-05-26T14:01:37.092254Z","steps":["trace[359451383] 'process raft request' (duration: 179.299295ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:01:37.092285Z","caller":"traceutil/trace.go:171","msg":"trace[1670288542] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7224; }","duration":"388.906606ms","start":"2026-05-26T14:01:36.703351Z","end":"2026-05-26T14:01:37.092258Z","steps":["trace[1670288542] 'agreement among raft nodes before linearized reading' (duration: 388.592138ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:01:37.092353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:01:36.70332Z","time spent":"389.02095ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-26T14:01:37.09235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.578876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8j77d\" ","response":"range_response_count:1 size:6530"} {"level":"warn","ts":"2026-05-26T14:01:37.092452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.967878ms","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-05-26T14:01:37.092557Z","caller":"traceutil/trace.go:171","msg":"trace[1215862668] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7224; }","duration":"389.118342ms","start":"2026-05-26T14:01:36.703401Z","end":"2026-05-26T14:01:37.09252Z","steps":["trace[1215862668] 'agreement among raft nodes before linearized reading' (duration: 388.861665ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:01:37.09253Z","caller":"traceutil/trace.go:171","msg":"trace[604333412] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8j77d; range_end:; response_count:1; response_revision:7224; }","duration":"343.801853ms","start":"2026-05-26T14:01:36.748676Z","end":"2026-05-26T14:01:37.092478Z","steps":["trace[604333412] 'agreement among raft nodes before linearized reading' (duration: 343.506004ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:01:37.092605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:01:36.703376Z","time spent":"389.219865ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-26T14:01:37.092624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:01:36.748659Z","time spent":"343.948166ms","remote":"127.0.0.1:43444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6553,"request content":"key:\"/registry/pods/openstack/keepalived-8j77d\" "} {"level":"warn","ts":"2026-05-26T14:01:40.35751Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305496303781826017,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-26T14:01:40.858136Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305496303781826017,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-26T14:01:41.358685Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305496303781826017,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-26T14:01:41.462678Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.974486336s","expected-duration":"1s"} {"level":"info","ts":"2026-05-26T14:01:41.475873Z","caller":"traceutil/trace.go:171","msg":"trace[661808458] transaction","detail":"{read_only:false; response_revision:7238; number_of_response:1; }","duration":"1.987791663s","start":"2026-05-26T14:01:39.488061Z","end":"2026-05-26T14:01:41.475853Z","steps":["trace[661808458] 'process raft request' (duration: 1.987628428s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:01:41.476017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:01:39.488033Z","time spent":"1.987905166s","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T14:01:42.732619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00076228s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-26T14:01:42.732736Z","caller":"traceutil/trace.go:171","msg":"trace[1750855776] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000946445s","start":"2026-05-26T14:01:40.731761Z","end":"2026-05-26T14:01:42.732707Z","steps":["trace[1750855776] 'agreement among raft nodes before linearized reading' (duration: 2.000797771s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:01:42.732798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:01:40.731743Z","time spent":"2.001044188s","remote":"127.0.0.1:43270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-26T14:01:43.587175Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.111397662s","expected-duration":"1s"} {"level":"info","ts":"2026-05-26T14:01:43.589575Z","caller":"traceutil/trace.go:171","msg":"trace[758545680] transaction","detail":"{read_only:false; response_revision:7241; number_of_response:1; }","duration":"3.325298351s","start":"2026-05-26T14:01:40.264257Z","end":"2026-05-26T14:01:43.589556Z","steps":["trace[758545680] 'process raft request' (duration: 3.324634032s)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:01:43.589582Z","caller":"traceutil/trace.go:171","msg":"trace[834739351] transaction","detail":"{read_only:false; response_revision:7239; number_of_response:1; }","duration":"3.69800948s","start":"2026-05-26T14:01:39.891544Z","end":"2026-05-26T14:01:43.589553Z","steps":["trace[834739351] 'process raft request' (duration: 3.697062304s)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:01:43.589649Z","caller":"traceutil/trace.go:171","msg":"trace[1821637111] transaction","detail":"{read_only:false; response_revision:7242; number_of_response:1; }","duration":"2.485057857s","start":"2026-05-26T14:01:41.104548Z","end":"2026-05-26T14:01:43.589606Z","steps":["trace[1821637111] 'process raft request' (duration: 2.484388499s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:01:43.589734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:01:40.264251Z","time spent":"3.325385043s","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T14:01:43.589755Z","caller":"traceutil/trace.go:171","msg":"trace[1389836765] transaction","detail":"{read_only:false; response_revision:7244; number_of_response:1; }","duration":"694.32241ms","start":"2026-05-26T14:01:42.895403Z","end":"2026-05-26T14:01:43.589726Z","steps":["trace[1389836765] 'process raft request' (duration: 694.230167ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:01:43.589751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:01:39.89152Z","time spent":"3.698137534s","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T14:01:43.589822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:01:41.104518Z","time spent":"2.485204351s","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T14:01:43.589898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:01:42.895378Z","time spent":"694.443013ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T14:01:43.589759Z","caller":"traceutil/trace.go:171","msg":"trace[1358851441] transaction","detail":"{read_only:false; response_revision:7243; number_of_response:1; }","duration":"1.780915567s","start":"2026-05-26T14:01:41.808802Z","end":"2026-05-26T14:01:43.589718Z","steps":["trace[1358851441] 'process raft request' (duration: 1.780776924s)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:01:43.58901Z","caller":"traceutil/trace.go:171","msg":"trace[581546100] linearizableReadLoop","detail":"{readStateIndex:7507; appliedIndex:7502; }","duration":"3.732271005s","start":"2026-05-26T14:01:39.856711Z","end":"2026-05-26T14:01:43.588982Z","steps":["trace[581546100] 'read index received' (duration: 1.619043543s)","trace[581546100] 'applied index is now lower than readState.Index' (duration: 2.113226352s)"],"step_count":2} {"level":"info","ts":"2026-05-26T14:01:43.589985Z","caller":"traceutil/trace.go:171","msg":"trace[328746582] transaction","detail":"{read_only:false; response_revision:7240; number_of_response:1; }","duration":"3.326073372s","start":"2026-05-26T14:01:40.263887Z","end":"2026-05-26T14:01:43.58996Z","steps":["trace[328746582] 'process raft request' (duration: 3.32490002s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:01:43.590485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:01:40.263868Z","time spent":"3.326571296s","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T14:01:43.590556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:01:41.808775Z","time spent":"1.781530624s","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T14:01:43.592245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.515949389s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T14:01:43.592293Z","caller":"traceutil/trace.go:171","msg":"trace[1964725104] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:7244; }","duration":"3.516046082s","start":"2026-05-26T14:01:40.076232Z","end":"2026-05-26T14:01:43.592278Z","steps":["trace[1964725104] 'agreement among raft nodes before linearized reading' (duration: 3.51596452s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:01:43.59232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:01:40.076208Z","time spent":"3.516104504s","remote":"127.0.0.1:39706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-26T14:01:43.592566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.735861135s","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-05-26T14:01:43.592596Z","caller":"traceutil/trace.go:171","msg":"trace[88259586] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:7244; }","duration":"3.735945856s","start":"2026-05-26T14:01:39.856644Z","end":"2026-05-26T14:01:43.592589Z","steps":["trace[88259586] 'agreement among raft nodes before linearized reading' (duration: 3.733135219s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:01:43.592617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:01:39.856618Z","time spent":"3.735993058s","remote":"127.0.0.1:43444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-05-26T14:01:43.592638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.477459897s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8j77d\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-05-26T14:01:43.592701Z","caller":"traceutil/trace.go:171","msg":"trace[1174145613] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8j77d; range_end:; response_count:1; response_revision:7244; }","duration":"2.477619282s","start":"2026-05-26T14:01:41.115067Z","end":"2026-05-26T14:01:43.592687Z","steps":["trace[1174145613] 'agreement among raft nodes before linearized reading' (duration: 2.477424007s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:01:43.592734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:01:41.11504Z","time spent":"2.477687153s","remote":"127.0.0.1:43444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6553,"request content":"key:\"/registry/pods/openstack/keepalived-8j77d\" "} {"level":"warn","ts":"2026-05-26T14:01:43.59276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.82671485s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T14:01:43.59279Z","caller":"traceutil/trace.go:171","msg":"trace[371733286] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:7244; }","duration":"2.826795082s","start":"2026-05-26T14:01:40.765988Z","end":"2026-05-26T14:01:43.592783Z","steps":["trace[371733286] 'agreement among raft nodes before linearized reading' (duration: 2.82674254s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:01:43.592781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.486483806s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-05-26T14:01:43.592843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.257754047s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-barbican\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T14:01:43.592829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.481381516s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-26T14:01:43.592865Z","caller":"traceutil/trace.go:171","msg":"trace[1029822040] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-barbican; range_end:; response_count:0; response_revision:7244; }","duration":"3.257802989s","start":"2026-05-26T14:01:40.335056Z","end":"2026-05-26T14:01:43.592859Z","steps":["trace[1029822040] 'agreement among raft nodes before linearized reading' (duration: 3.257769878s)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:01:43.592864Z","caller":"traceutil/trace.go:171","msg":"trace[776228529] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7244; }","duration":"2.486605379s","start":"2026-05-26T14:01:41.106226Z","end":"2026-05-26T14:01:43.592831Z","steps":["trace[776228529] 'agreement among raft nodes before linearized reading' (duration: 2.486391023s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:01:43.592888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:01:40.335046Z","time spent":"3.257837951s","remote":"127.0.0.1:56216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-barbican\" "} {"level":"warn","ts":"2026-05-26T14:01:43.592908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:01:41.106205Z","time spent":"2.486691952s","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-26T14:01:43.592886Z","caller":"traceutil/trace.go:171","msg":"trace[1065427126] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7244; }","duration":"2.481439897s","start":"2026-05-26T14:01:41.11143Z","end":"2026-05-26T14:01:43.59287Z","steps":["trace[1065427126] 'agreement among raft nodes before linearized reading' (duration: 2.481290273s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:01:43.592949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:01:41.111413Z","time spent":"2.481529649s","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-26T14:01:43.593039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.481744206s","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-26T14:01:43.59303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.644026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-05-26T14:01:43.593053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.48118659s","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-05-26T14:01:43.593068Z","caller":"traceutil/trace.go:171","msg":"trace[486683492] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7244; }","duration":"2.481785766s","start":"2026-05-26T14:01:41.111276Z","end":"2026-05-26T14:01:43.593061Z","steps":["trace[486683492] 'agreement among raft nodes before linearized reading' (duration: 2.481707894s)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:01:43.593078Z","caller":"traceutil/trace.go:171","msg":"trace[112914432] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7244; }","duration":"2.481219531s","start":"2026-05-26T14:01:41.111851Z","end":"2026-05-26T14:01:43.593071Z","steps":["trace[112914432] 'agreement among raft nodes before linearized reading' (duration: 2.481154749s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:01:43.593091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:01:41.11127Z","time spent":"2.481815777s","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-26T14:01:43.5931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"698.33834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T14:01:43.593127Z","caller":"traceutil/trace.go:171","msg":"trace[1882005040] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7244; }","duration":"698.388172ms","start":"2026-05-26T14:01:42.894733Z","end":"2026-05-26T14:01:43.593121Z","steps":["trace[1882005040] 'agreement among raft nodes before linearized reading' (duration: 698.351771ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:01:43.593104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:01:41.111847Z","time spent":"2.481250931s","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-26T14:01:43.593147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:01:42.894726Z","time spent":"698.416973ms","remote":"127.0.0.1:43280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-26T14:01:43.593071Z","caller":"traceutil/trace.go:171","msg":"trace[1543337754] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7244; }","duration":"112.719569ms","start":"2026-05-26T14:01:43.480345Z","end":"2026-05-26T14:01:43.593064Z","steps":["trace[1543337754] 'agreement among raft nodes before linearized reading' (duration: 112.636866ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:01:43.592814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:01:40.765962Z","time spent":"2.826845833s","remote":"127.0.0.1:43762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":10,"response size":30,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"warn","ts":"2026-05-26T14:01:43.593248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"698.642029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T14:01:43.593282Z","caller":"traceutil/trace.go:171","msg":"trace[1464793647] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:7244; }","duration":"698.736131ms","start":"2026-05-26T14:01:42.894538Z","end":"2026-05-26T14:01:43.593275Z","steps":["trace[1464793647] 'agreement among raft nodes before linearized reading' (duration: 698.68278ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:01:43.593306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.052574649s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-26T14:01:43.593315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:01:42.89451Z","time spent":"698.798473ms","remote":"127.0.0.1:39644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"info","ts":"2026-05-26T14:01:43.593338Z","caller":"traceutil/trace.go:171","msg":"trace[1282261150] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:7244; }","duration":"2.052660412s","start":"2026-05-26T14:01:41.54067Z","end":"2026-05-26T14:01:43.593331Z","steps":["trace[1282261150] 'agreement among raft nodes before linearized reading' (duration: 2.05260072s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:01:43.593363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:01:41.540648Z","time spent":"2.052707073s","remote":"127.0.0.1:34090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":6,"response size":30,"request content":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true "} {"level":"info","ts":"2026-05-26T14:03:24.986862Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5914} {"level":"info","ts":"2026-05-26T14:03:25.064701Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5914,"took":"76.306184ms","hash":3363522318,"current-db-size-bytes":56995840,"current-db-size":"57 MB","current-db-size-in-use-bytes":26374144,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-05-26T14:03:25.064771Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3363522318,"revision":5914,"compact-revision":2973} {"level":"info","ts":"2026-05-26T14:04:24.380128Z","caller":"traceutil/trace.go:171","msg":"trace[983243789] transaction","detail":"{read_only:false; response_revision:8570; number_of_response:1; }","duration":"144.757742ms","start":"2026-05-26T14:04:24.235344Z","end":"2026-05-26T14:04:24.380102Z","steps":["trace[983243789] 'process raft request' (duration: 144.512306ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:04:24.431992Z","caller":"traceutil/trace.go:171","msg":"trace[1212692603] transaction","detail":"{read_only:false; response_revision:8571; number_of_response:1; }","duration":"188.036576ms","start":"2026-05-26T14:04:24.243935Z","end":"2026-05-26T14:04:24.431971Z","steps":["trace[1212692603] 'process raft request' (duration: 187.761868ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:04:24.431987Z","caller":"traceutil/trace.go:171","msg":"trace[70476368] transaction","detail":"{read_only:false; response_revision:8573; number_of_response:1; }","duration":"184.931901ms","start":"2026-05-26T14:04:24.247025Z","end":"2026-05-26T14:04:24.431957Z","steps":["trace[70476368] 'process raft request' (duration: 184.880359ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:04:24.432089Z","caller":"traceutil/trace.go:171","msg":"trace[138046873] transaction","detail":"{read_only:false; response_revision:8572; number_of_response:1; }","duration":"185.61899ms","start":"2026-05-26T14:04:24.246432Z","end":"2026-05-26T14:04:24.432051Z","steps":["trace[138046873] 'process raft request' (duration: 185.430265ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:04:24.74742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.076249ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T14:04:24.747877Z","caller":"traceutil/trace.go:171","msg":"trace[12765704] transaction","detail":"{read_only:false; response_revision:8574; number_of_response:1; }","duration":"307.966245ms","start":"2026-05-26T14:04:24.439868Z","end":"2026-05-26T14:04:24.747834Z","steps":["trace[12765704] 'process raft request' (duration: 20.379022ms)","trace[12765704] 'compare' (duration: 286.941995ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T14:04:24.748006Z","caller":"traceutil/trace.go:171","msg":"trace[1753599200] transaction","detail":"{read_only:false; response_revision:8575; number_of_response:1; }","duration":"306.290379ms","start":"2026-05-26T14:04:24.441683Z","end":"2026-05-26T14:04:24.747973Z","steps":["trace[1753599200] 'process raft request' (duration: 305.854647ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:04:24.748159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:04:24.441661Z","time spent":"306.412173ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T14:04:24.748087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:04:24.439851Z","time spent":"308.12287ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T14:04:24.748203Z","caller":"traceutil/trace.go:171","msg":"trace[1879587675] transaction","detail":"{read_only:false; response_revision:8576; number_of_response:1; }","duration":"306.463484ms","start":"2026-05-26T14:04:24.441724Z","end":"2026-05-26T14:04:24.748187Z","steps":["trace[1879587675] 'process raft request' (duration: 306.125225ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:04:24.748311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:04:24.441694Z","time spent":"306.574437ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T14:04:24.748556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.81679ms","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-26T14:04:24.748607Z","caller":"traceutil/trace.go:171","msg":"trace[1886284965] linearizableReadLoop","detail":"{readStateIndex:8883; appliedIndex:8880; }","duration":"291.426559ms","start":"2026-05-26T14:04:24.456705Z","end":"2026-05-26T14:04:24.748132Z","steps":["trace[1886284965] 'read index received' (duration: 3.559148ms)","trace[1886284965] 'applied index is now lower than readState.Index' (duration: 287.865121ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T14:04:24.748665Z","caller":"traceutil/trace.go:171","msg":"trace[1627931465] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8576; }","duration":"291.968394ms","start":"2026-05-26T14:04:24.456667Z","end":"2026-05-26T14:04:24.748636Z","steps":["trace[1627931465] 'agreement among raft nodes before linearized reading' (duration: 291.638015ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:04:24.748772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.240945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8j77d\" ","response":"range_response_count:1 size:6530"} {"level":"warn","ts":"2026-05-26T14:04:24.748807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.151869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T14:04:24.748814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.357163ms","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-05-26T14:04:24.748825Z","caller":"traceutil/trace.go:171","msg":"trace[626508844] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8j77d; range_end:; response_count:1; response_revision:8576; }","duration":"125.342378ms","start":"2026-05-26T14:04:24.623469Z","end":"2026-05-26T14:04:24.748811Z","steps":["trace[626508844] 'agreement among raft nodes before linearized reading' (duration: 125.237795ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:04:24.748845Z","caller":"traceutil/trace.go:171","msg":"trace[1869470377] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8576; }","duration":"143.233461ms","start":"2026-05-26T14:04:24.605601Z","end":"2026-05-26T14:04:24.748835Z","steps":["trace[1869470377] 'agreement among raft nodes before linearized reading' (duration: 143.154189ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:04:24.748853Z","caller":"traceutil/trace.go:171","msg":"trace[738614463] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8576; }","duration":"264.438885ms","start":"2026-05-26T14:04:24.4844Z","end":"2026-05-26T14:04:24.748839Z","steps":["trace[738614463] 'agreement among raft nodes before linearized reading' (duration: 264.295981ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:04:26.586648Z","caller":"traceutil/trace.go:171","msg":"trace[460523996] transaction","detail":"{read_only:false; response_revision:8581; number_of_response:1; }","duration":"149.134393ms","start":"2026-05-26T14:04:26.437476Z","end":"2026-05-26T14:04:26.58661Z","steps":["trace[460523996] 'process raft request' (duration: 57.078315ms)","trace[460523996] 'compare' (duration: 91.777091ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T14:04:26.586826Z","caller":"traceutil/trace.go:171","msg":"trace[656868089] transaction","detail":"{read_only:false; response_revision:8582; number_of_response:1; }","duration":"148.995369ms","start":"2026-05-26T14:04:26.437787Z","end":"2026-05-26T14:04:26.586783Z","steps":["trace[656868089] 'process raft request' (duration: 148.768223ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:04:53.15161Z","caller":"traceutil/trace.go:171","msg":"trace[290176429] transaction","detail":"{read_only:false; response_revision:8782; number_of_response:1; }","duration":"208.307635ms","start":"2026-05-26T14:04:52.943275Z","end":"2026-05-26T14:04:53.151583Z","steps":["trace[290176429] 'process raft request' (duration: 208.09563ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:04:53.360919Z","caller":"traceutil/trace.go:171","msg":"trace[1404544972] linearizableReadLoop","detail":"{readStateIndex:9100; appliedIndex:9095; }","duration":"404.761285ms","start":"2026-05-26T14:04:52.956129Z","end":"2026-05-26T14:04:53.36089Z","steps":["trace[1404544972] 'read index received' (duration: 195.223745ms)","trace[1404544972] 'applied index is now lower than readState.Index' (duration: 209.5362ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T14:04:53.360937Z","caller":"traceutil/trace.go:171","msg":"trace[321460241] transaction","detail":"{read_only:false; response_revision:8784; number_of_response:1; }","duration":"414.02297ms","start":"2026-05-26T14:04:52.946882Z","end":"2026-05-26T14:04:53.360905Z","steps":["trace[321460241] 'process raft request' (duration: 413.795374ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:04:53.360944Z","caller":"traceutil/trace.go:171","msg":"trace[1185318368] transaction","detail":"{read_only:false; response_revision:8785; number_of_response:1; }","duration":"413.27087ms","start":"2026-05-26T14:04:52.947653Z","end":"2026-05-26T14:04:53.360924Z","steps":["trace[1185318368] 'process raft request' (duration: 413.067494ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:04:53.361024Z","caller":"traceutil/trace.go:171","msg":"trace[559512428] transaction","detail":"{read_only:false; response_revision:8786; number_of_response:1; }","duration":"413.270239ms","start":"2026-05-26T14:04:52.947709Z","end":"2026-05-26T14:04:53.360979Z","steps":["trace[559512428] 'process raft request' (duration: 413.131856ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:04:53.361145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:04:52.946874Z","time spent":"414.144063ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T14:04:53.36116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:04:52.947641Z","time spent":"413.405723ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T14:04:53.361232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.066853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8j77d\" ","response":"range_response_count:1 size:6530"} {"level":"warn","ts":"2026-05-26T14:04:53.361236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:04:52.947706Z","time spent":"413.421543ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T14:04:53.361288Z","caller":"traceutil/trace.go:171","msg":"trace[979962475] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8j77d; range_end:; response_count:1; response_revision:8786; }","duration":"405.151206ms","start":"2026-05-26T14:04:52.956125Z","end":"2026-05-26T14:04:53.361276Z","steps":["trace[979962475] 'agreement among raft nodes before linearized reading' (duration: 404.912489ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:04:53.361339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:04:52.956103Z","time spent":"405.224247ms","remote":"127.0.0.1:43444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6553,"request content":"key:\"/registry/pods/openstack/keepalived-8j77d\" "} {"level":"info","ts":"2026-05-26T14:04:53.360881Z","caller":"traceutil/trace.go:171","msg":"trace[1524858179] transaction","detail":"{read_only:false; response_revision:8783; number_of_response:1; }","duration":"414.568135ms","start":"2026-05-26T14:04:52.946265Z","end":"2026-05-26T14:04:53.360833Z","steps":["trace[1524858179] 'process raft request' (duration: 414.147914ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:04:53.361396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.777956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T14:04:53.361444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:04:52.946255Z","time spent":"415.12469ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T14:04:53.361533Z","caller":"traceutil/trace.go:171","msg":"trace[1880012133] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:8786; }","duration":"354.972301ms","start":"2026-05-26T14:04:53.006533Z","end":"2026-05-26T14:04:53.361505Z","steps":["trace[1880012133] 'agreement among raft nodes before linearized reading' (duration: 354.554809ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:04:53.361728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:04:53.006522Z","time spent":"355.183887ms","remote":"127.0.0.1:39630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-05-26T14:04:57.572782Z","caller":"traceutil/trace.go:171","msg":"trace[633865877] linearizableReadLoop","detail":"{readStateIndex:9117; appliedIndex:9115; }","duration":"181.28841ms","start":"2026-05-26T14:04:57.391473Z","end":"2026-05-26T14:04:57.572762Z","steps":["trace[633865877] 'read index received' (duration: 86.001922ms)","trace[633865877] 'applied index is now lower than readState.Index' (duration: 95.285668ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T14:04:57.572876Z","caller":"traceutil/trace.go:171","msg":"trace[1282942895] transaction","detail":"{read_only:false; response_revision:8804; number_of_response:1; }","duration":"181.25763ms","start":"2026-05-26T14:04:57.391611Z","end":"2026-05-26T14:04:57.572868Z","steps":["trace[1282942895] 'process raft request' (duration: 181.126326ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:04:57.572848Z","caller":"traceutil/trace.go:171","msg":"trace[1015490142] transaction","detail":"{read_only:false; response_revision:8803; number_of_response:1; }","duration":"181.26993ms","start":"2026-05-26T14:04:57.391537Z","end":"2026-05-26T14:04:57.572807Z","steps":["trace[1015490142] 'process raft request' (duration: 181.180468ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:04:57.572885Z","caller":"traceutil/trace.go:171","msg":"trace[1974588702] transaction","detail":"{read_only:false; response_revision:8802; number_of_response:1; }","duration":"181.499287ms","start":"2026-05-26T14:04:57.391358Z","end":"2026-05-26T14:04:57.572857Z","steps":["trace[1974588702] 'process raft request' (duration: 181.209019ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:04:57.57305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.555977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8j77d\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-05-26T14:04:57.573077Z","caller":"traceutil/trace.go:171","msg":"trace[1060288279] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8j77d; range_end:; response_count:1; response_revision:8804; }","duration":"181.61507ms","start":"2026-05-26T14:04:57.391456Z","end":"2026-05-26T14:04:57.573071Z","steps":["trace[1060288279] 'agreement among raft nodes before linearized reading' (duration: 181.544438ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:04:57.573257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.185918ms","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-05-26T14:04:57.573374Z","caller":"traceutil/trace.go:171","msg":"trace[2057619369] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8804; }","duration":"127.377013ms","start":"2026-05-26T14:04:57.445977Z","end":"2026-05-26T14:04:57.573354Z","steps":["trace[2057619369] 'agreement among raft nodes before linearized reading' (duration: 127.030224ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:05:07.462988Z","caller":"traceutil/trace.go:171","msg":"trace[20581338] transaction","detail":"{read_only:false; response_revision:8899; number_of_response:1; }","duration":"179.758008ms","start":"2026-05-26T14:05:07.283197Z","end":"2026-05-26T14:05:07.462955Z","steps":["trace[20581338] 'process raft request' (duration: 179.345627ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:05:12.820112Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000243a.wal"} {"level":"info","ts":"2026-05-26T14:06:19.803077Z","caller":"traceutil/trace.go:171","msg":"trace[1918530990] linearizableReadLoop","detail":"{readStateIndex:9964; appliedIndex:9963; }","duration":"158.55975ms","start":"2026-05-26T14:06:19.644487Z","end":"2026-05-26T14:06:19.803047Z","steps":["trace[1918530990] 'read index received' (duration: 158.270222ms)","trace[1918530990] 'applied index is now lower than readState.Index' (duration: 288.328µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T14:06:19.803141Z","caller":"traceutil/trace.go:171","msg":"trace[158508233] transaction","detail":"{read_only:false; response_revision:9623; number_of_response:1; }","duration":"197.578732ms","start":"2026-05-26T14:06:19.605529Z","end":"2026-05-26T14:06:19.803108Z","steps":["trace[158508233] 'process raft request' (duration: 197.356186ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:06:19.803365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.756066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T14:06:19.803419Z","caller":"traceutil/trace.go:171","msg":"trace[1674705708] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:9623; }","duration":"158.932271ms","start":"2026-05-26T14:06:19.644472Z","end":"2026-05-26T14:06:19.803404Z","steps":["trace[1674705708] 'agreement among raft nodes before linearized reading' (duration: 158.728745ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:06:23.660459Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"1cac722af8b2b8a6","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-26T14:06:23.66589Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-05-26T14:06:23.666045Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-05-26T14:08:24.993886Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8062} {"level":"info","ts":"2026-05-26T14:08:25.054214Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8062,"took":"58.806617ms","hash":1534784933,"current-db-size-bytes":56995840,"current-db-size":"57 MB","current-db-size-in-use-bytes":27824128,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-05-26T14:08:25.054268Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1534784933,"revision":8062,"compact-revision":5914} {"level":"warn","ts":"2026-05-26T14:09:51.514345Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305496303781837039,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-26T14:09:52.014802Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305496303781837039,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-26T14:09:52.515575Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305496303781837039,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-26T14:09:52.900196Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.886227351s","expected-duration":"1s"} {"level":"info","ts":"2026-05-26T14:09:52.901015Z","caller":"traceutil/trace.go:171","msg":"trace[777851283] transaction","detail":"{read_only:false; response_revision:11404; number_of_response:1; }","duration":"1.887147356s","start":"2026-05-26T14:09:51.013845Z","end":"2026-05-26T14:09:52.900993Z","steps":["trace[777851283] 'process raft request' (duration: 1.886467897s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:09:52.901131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:09:51.01383Z","time spent":"1.887242048s","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T14:09:52.908314Z","caller":"traceutil/trace.go:171","msg":"trace[1398760907] transaction","detail":"{read_only:false; response_revision:11406; number_of_response:1; }","duration":"1.199972098s","start":"2026-05-26T14:09:51.708318Z","end":"2026-05-26T14:09:52.90829Z","steps":["trace[1398760907] 'process raft request' (duration: 1.199911497s)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:09:52.908358Z","caller":"traceutil/trace.go:171","msg":"trace[1054517174] transaction","detail":"{read_only:false; response_revision:11405; number_of_response:1; }","duration":"1.894197279s","start":"2026-05-26T14:09:51.01413Z","end":"2026-05-26T14:09:52.908327Z","steps":["trace[1054517174] 'process raft request' (duration: 1.893980873s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:09:52.908447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:09:51.708274Z","time spent":"1.200097912s","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T14:09:52.908511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:09:51.01412Z","time spent":"1.894305812s","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T14:09:52.908609Z","caller":"traceutil/trace.go:171","msg":"trace[997866345] transaction","detail":"{read_only:false; response_revision:11407; number_of_response:1; }","duration":"1.192545724s","start":"2026-05-26T14:09:51.716055Z","end":"2026-05-26T14:09:52.908601Z","steps":["trace[997866345] 'process raft request' (duration: 1.192206625s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:09:52.908659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:09:51.716034Z","time spent":"1.192602656s","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T14:09:52.908755Z","caller":"traceutil/trace.go:171","msg":"trace[2078492070] transaction","detail":"{read_only:false; response_revision:11408; number_of_response:1; }","duration":"1.079098604s","start":"2026-05-26T14:09:51.829649Z","end":"2026-05-26T14:09:52.908748Z","steps":["trace[2078492070] 'process raft request' (duration: 1.078876558s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:09:52.908794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:09:51.829618Z","time spent":"1.079156466s","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T14:09:52.908802Z","caller":"traceutil/trace.go:171","msg":"trace[761706889] linearizableReadLoop","detail":"{readStateIndex:11802; appliedIndex:11795; }","duration":"1.894790236s","start":"2026-05-26T14:09:51.014001Z","end":"2026-05-26T14:09:52.908791Z","steps":["trace[761706889] 'read index received' (duration: 1.886376915s)","trace[761706889] 'applied index is now lower than readState.Index' (duration: 8.412571ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T14:09:52.908779Z","caller":"traceutil/trace.go:171","msg":"trace[1998766463] transaction","detail":"{read_only:false; response_revision:11409; number_of_response:1; }","duration":"1.078664592s","start":"2026-05-26T14:09:51.830091Z","end":"2026-05-26T14:09:52.908756Z","steps":["trace[1998766463] 'process raft request' (duration: 1.078565009s)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:09:52.908896Z","caller":"traceutil/trace.go:171","msg":"trace[914406533] transaction","detail":"{read_only:false; response_revision:11410; number_of_response:1; }","duration":"680.606126ms","start":"2026-05-26T14:09:52.228248Z","end":"2026-05-26T14:09:52.908855Z","steps":["trace[914406533] 'process raft request' (duration: 680.464322ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:09:52.908939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:09:51.830078Z","time spent":"1.078823167s","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T14:09:52.909057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.895036533s","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-05-26T14:09:52.909086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:09:52.22822Z","time spent":"680.76775ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T14:09:52.909122Z","caller":"traceutil/trace.go:171","msg":"trace[1374368747] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:11410; }","duration":"1.895143036s","start":"2026-05-26T14:09:51.013965Z","end":"2026-05-26T14:09:52.909108Z","steps":["trace[1374368747] 'agreement among raft nodes before linearized reading' (duration: 1.89491758s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:09:52.909144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.278293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T14:09:52.909163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:09:51.013951Z","time spent":"1.895205097s","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-26T14:09:52.909166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.301233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T14:09:52.909214Z","caller":"traceutil/trace.go:171","msg":"trace[520209123] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:11410; }","duration":"230.379065ms","start":"2026-05-26T14:09:52.678814Z","end":"2026-05-26T14:09:52.909193Z","steps":["trace[520209123] 'agreement among raft nodes before linearized reading' (duration: 230.331244ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:09:52.909262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.578908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:1 size:5077"} {"level":"info","ts":"2026-05-26T14:09:52.909285Z","caller":"traceutil/trace.go:171","msg":"trace[645326349] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:11410; }","duration":"171.625209ms","start":"2026-05-26T14:09:52.737654Z","end":"2026-05-26T14:09:52.909279Z","steps":["trace[645326349] 'agreement among raft nodes before linearized reading' (duration: 171.536847ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:09:52.909356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.069306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T14:09:52.909379Z","caller":"traceutil/trace.go:171","msg":"trace[1727042173] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:11410; }","duration":"174.101828ms","start":"2026-05-26T14:09:52.735272Z","end":"2026-05-26T14:09:52.909374Z","steps":["trace[1727042173] 'agreement among raft nodes before linearized reading' (duration: 174.068497ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:09:52.909376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.075297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/cinder-api\" ","response":"range_response_count:1 size:667"} {"level":"info","ts":"2026-05-26T14:09:52.909423Z","caller":"traceutil/trace.go:171","msg":"trace[749217411] range","detail":"{range_begin:/registry/services/endpoints/openstack/cinder-api; range_end:; response_count:1; response_revision:11410; }","duration":"174.146529ms","start":"2026-05-26T14:09:52.735266Z","end":"2026-05-26T14:09:52.909412Z","steps":["trace[749217411] 'agreement among raft nodes before linearized reading' (duration: 174.018166ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:09:52.909439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.628763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T14:09:52.90947Z","caller":"traceutil/trace.go:171","msg":"trace[1477891392] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:11410; }","duration":"230.668433ms","start":"2026-05-26T14:09:52.678793Z","end":"2026-05-26T14:09:52.909461Z","steps":["trace[1477891392] 'agreement among raft nodes before linearized reading' (duration: 230.621502ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:09:52.9091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.891478305s","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-05-26T14:09:52.909497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.246741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T14:09:52.909521Z","caller":"traceutil/trace.go:171","msg":"trace[70435866] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:11410; }","duration":"1.891943247s","start":"2026-05-26T14:09:51.017569Z","end":"2026-05-26T14:09:52.909512Z","steps":["trace[70435866] 'agreement among raft nodes before linearized reading' (duration: 1.891383761s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:09:52.909562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:09:51.017554Z","time spent":"1.891997229s","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-26T14:09:52.909585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.663288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:1 size:5077"} {"level":"warn","ts":"2026-05-26T14:09:52.909597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.276172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T14:09:52.909527Z","caller":"traceutil/trace.go:171","msg":"trace[57563377] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:11410; }","duration":"174.326694ms","start":"2026-05-26T14:09:52.735187Z","end":"2026-05-26T14:09:52.909514Z","steps":["trace[57563377] 'agreement among raft nodes before linearized reading' (duration: 174.291323ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:09:52.909627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.839318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T14:09:52.909662Z","caller":"traceutil/trace.go:171","msg":"trace[1155130350] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:11410; }","duration":"230.89964ms","start":"2026-05-26T14:09:52.678754Z","end":"2026-05-26T14:09:52.909654Z","steps":["trace[1155130350] 'agreement among raft nodes before linearized reading' (duration: 230.852528ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:09:52.909673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.369905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T14:09:52.9097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.303091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T14:09:52.909177Z","caller":"traceutil/trace.go:171","msg":"trace[226494954] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:11410; }","duration":"230.355684ms","start":"2026-05-26T14:09:52.678814Z","end":"2026-05-26T14:09:52.90917Z","steps":["trace[226494954] 'agreement among raft nodes before linearized reading' (duration: 230.307803ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:09:52.909727Z","caller":"traceutil/trace.go:171","msg":"trace[1948886255] range","detail":"{range_begin:/registry/secretgen.k14s.io/rsakeys/; range_end:/registry/secretgen.k14s.io/rsakeys0; response_count:0; response_revision:11410; }","duration":"299.362243ms","start":"2026-05-26T14:09:52.610358Z","end":"2026-05-26T14:09:52.90972Z","steps":["trace[1948886255] 'agreement among raft nodes before linearized reading' (duration: 299.324491ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:09:52.90961Z","caller":"traceutil/trace.go:171","msg":"trace[250300286] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:11410; }","duration":"228.690968ms","start":"2026-05-26T14:09:52.680914Z","end":"2026-05-26T14:09:52.909605Z","steps":["trace[250300286] 'agreement among raft nodes before linearized reading' (duration: 228.631157ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:09:52.909853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.960561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T14:09:52.909879Z","caller":"traceutil/trace.go:171","msg":"trace[1114842692] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:11410; }","duration":"307.030983ms","start":"2026-05-26T14:09:52.602842Z","end":"2026-05-26T14:09:52.909873Z","steps":["trace[1114842692] 'agreement among raft nodes before linearized reading' (duration: 306.992082ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:09:52.909948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:09:52.602818Z","time spent":"307.120386ms","remote":"127.0.0.1:43270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-26T14:09:52.909701Z","caller":"traceutil/trace.go:171","msg":"trace[1836831477] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:11410; }","duration":"174.397636ms","start":"2026-05-26T14:09:52.735296Z","end":"2026-05-26T14:09:52.909694Z","steps":["trace[1836831477] 'agreement among raft nodes before linearized reading' (duration: 174.356925ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:09:52.909669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.573891891s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T14:09:52.910098Z","caller":"traceutil/trace.go:171","msg":"trace[318499774] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/; range_end:/registry/monitoring.coreos.com/prometheuses0; response_count:0; response_revision:11410; }","duration":"1.574359694s","start":"2026-05-26T14:09:51.33573Z","end":"2026-05-26T14:09:52.91009Z","steps":["trace[318499774] 'agreement among raft nodes before linearized reading' (duration: 1.573916402s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:09:52.910121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:09:51.335705Z","time spent":"1.574408475s","remote":"127.0.0.1:34102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":1,"response size":30,"request content":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true "} {"level":"warn","ts":"2026-05-26T14:09:52.910159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.32406876s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8j77d\" ","response":"range_response_count:1 size:6530"} {"level":"warn","ts":"2026-05-26T14:09:52.910178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.564592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"info","ts":"2026-05-26T14:09:52.910194Z","caller":"traceutil/trace.go:171","msg":"trace[829862973] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8j77d; range_end:; response_count:1; response_revision:11410; }","duration":"1.324148183s","start":"2026-05-26T14:09:51.586037Z","end":"2026-05-26T14:09:52.910185Z","steps":["trace[829862973] 'agreement among raft nodes before linearized reading' (duration: 1.324083682s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:09:52.910221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:09:51.586012Z","time spent":"1.324201964s","remote":"127.0.0.1:43444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6553,"request content":"key:\"/registry/pods/openstack/keepalived-8j77d\" "} {"level":"info","ts":"2026-05-26T14:09:52.910222Z","caller":"traceutil/trace.go:171","msg":"trace[977531595] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:11410; }","duration":"681.650735ms","start":"2026-05-26T14:09:52.228556Z","end":"2026-05-26T14:09:52.910207Z","steps":["trace[977531595] 'agreement among raft nodes before linearized reading' (duration: 681.561362ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:09:52.910254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:09:52.228531Z","time spent":"681.715756ms","remote":"127.0.0.1:43426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":1876,"request content":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-05-26T14:09:52.909635Z","caller":"traceutil/trace.go:171","msg":"trace[775998190] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:11410; }","duration":"174.324084ms","start":"2026-05-26T14:09:52.735302Z","end":"2026-05-26T14:09:52.909626Z","steps":["trace[775998190] 'agreement among raft nodes before linearized reading' (duration: 174.264752ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:10:05.092385Z","caller":"traceutil/trace.go:171","msg":"trace[1097300938] transaction","detail":"{read_only:false; response_revision:11472; number_of_response:1; }","duration":"141.114261ms","start":"2026-05-26T14:10:04.951242Z","end":"2026-05-26T14:10:05.092357Z","steps":["trace[1097300938] 'process raft request' (duration: 140.927326ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:10:05.154581Z","caller":"traceutil/trace.go:171","msg":"trace[1256099248] transaction","detail":"{read_only:false; response_revision:11473; number_of_response:1; }","duration":"202.250772ms","start":"2026-05-26T14:10:04.952295Z","end":"2026-05-26T14:10:05.154546Z","steps":["trace[1256099248] 'process raft request' (duration: 178.749666ms)","trace[1256099248] 'compare' (duration: 23.2635ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T14:10:05.154892Z","caller":"traceutil/trace.go:171","msg":"trace[242609505] transaction","detail":"{read_only:false; response_revision:11474; number_of_response:1; }","duration":"191.076695ms","start":"2026-05-26T14:10:04.96379Z","end":"2026-05-26T14:10:05.154867Z","steps":["trace[242609505] 'process raft request' (duration: 190.691644ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:10:05.155008Z","caller":"traceutil/trace.go:171","msg":"trace[401225058] linearizableReadLoop","detail":"{readStateIndex:11869; appliedIndex:11866; }","duration":"190.273693ms","start":"2026-05-26T14:10:04.964708Z","end":"2026-05-26T14:10:05.154982Z","steps":["trace[401225058] 'read index received' (duration: 127.457696ms)","trace[401225058] 'applied index is now lower than readState.Index' (duration: 62.814607ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T14:10:05.154929Z","caller":"traceutil/trace.go:171","msg":"trace[1057015843] transaction","detail":"{read_only:false; response_revision:11475; number_of_response:1; }","duration":"184.313129ms","start":"2026-05-26T14:10:04.970592Z","end":"2026-05-26T14:10:05.154905Z","steps":["trace[1057015843] 'process raft request' (duration: 184.150284ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:10:05.155008Z","caller":"traceutil/trace.go:171","msg":"trace[520861644] transaction","detail":"{read_only:false; response_revision:11476; number_of_response:1; }","duration":"135.498666ms","start":"2026-05-26T14:10:05.019496Z","end":"2026-05-26T14:10:05.154995Z","steps":["trace[520861644] 'process raft request' (duration: 135.364863ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:10:05.15528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.550081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/cinder-api\" ","response":"range_response_count:1 size:667"} {"level":"info","ts":"2026-05-26T14:10:05.155351Z","caller":"traceutil/trace.go:171","msg":"trace[850324204] range","detail":"{range_begin:/registry/services/endpoints/openstack/cinder-api; range_end:; response_count:1; response_revision:11476; }","duration":"190.679844ms","start":"2026-05-26T14:10:04.964656Z","end":"2026-05-26T14:10:05.155336Z","steps":["trace[850324204] 'agreement among raft nodes before linearized reading' (duration: 190.435607ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:10:05.175365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.424015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T14:10:05.175426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.863143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T14:10:05.175463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.354319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:1 size:5077"} {"level":"info","ts":"2026-05-26T14:10:05.175506Z","caller":"traceutil/trace.go:171","msg":"trace[1548801080] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:11477; }","duration":"204.977357ms","start":"2026-05-26T14:10:04.970508Z","end":"2026-05-26T14:10:05.175485Z","steps":["trace[1548801080] 'agreement among raft nodes before linearized reading' (duration: 204.808792ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:10:05.175531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.157972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T14:10:05.175561Z","caller":"traceutil/trace.go:171","msg":"trace[1216649002] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:11477; }","duration":"205.198303ms","start":"2026-05-26T14:10:04.970355Z","end":"2026-05-26T14:10:05.175553Z","steps":["trace[1216649002] 'agreement among raft nodes before linearized reading' (duration: 205.147031ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:10:05.175483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.997968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T14:10:05.17559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.679221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-05-26T14:10:05.175588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.1064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T14:10:05.175628Z","caller":"traceutil/trace.go:171","msg":"trace[1215032960] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:11477; }","duration":"205.208803ms","start":"2026-05-26T14:10:04.970395Z","end":"2026-05-26T14:10:05.175604Z","steps":["trace[1215032960] 'agreement among raft nodes before linearized reading' (duration: 204.982177ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:10:05.175691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.587288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T14:10:05.175531Z","caller":"traceutil/trace.go:171","msg":"trace[1660429197] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:11477; }","duration":"204.458003ms","start":"2026-05-26T14:10:04.971058Z","end":"2026-05-26T14:10:05.175516Z","steps":["trace[1660429197] 'agreement among raft nodes before linearized reading' (duration: 204.234056ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:10:05.17569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.739622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-05-26T14:10:05.175734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.447469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8j77d\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-05-26T14:10:05.175784Z","caller":"traceutil/trace.go:171","msg":"trace[65240003] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:11477; }","duration":"191.865186ms","start":"2026-05-26T14:10:04.983893Z","end":"2026-05-26T14:10:05.175759Z","steps":["trace[65240003] 'agreement among raft nodes before linearized reading' (duration: 191.559788ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:10:05.175773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.818023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T14:10:05.175835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.603486ms","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-26T14:10:05.175708Z","caller":"traceutil/trace.go:171","msg":"trace[1528918704] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:11477; }","duration":"191.723832ms","start":"2026-05-26T14:10:04.983884Z","end":"2026-05-26T14:10:05.175607Z","steps":["trace[1528918704] 'agreement among raft nodes before linearized reading' (duration: 191.66421ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:10:05.175859Z","caller":"traceutil/trace.go:171","msg":"trace[334606789] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:11477; }","duration":"192.655438ms","start":"2026-05-26T14:10:04.983196Z","end":"2026-05-26T14:10:05.175852Z","steps":["trace[334606789] 'agreement among raft nodes before linearized reading' (duration: 192.552245ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:10:05.175854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.892875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:1 size:5077"} {"level":"info","ts":"2026-05-26T14:10:05.175473Z","caller":"traceutil/trace.go:171","msg":"trace[225792557] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:11477; }","duration":"207.582609ms","start":"2026-05-26T14:10:04.967871Z","end":"2026-05-26T14:10:05.175454Z","steps":["trace[225792557] 'agreement among raft nodes before linearized reading' (duration: 207.392324ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:10:05.175882Z","caller":"traceutil/trace.go:171","msg":"trace[961718241] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:11477; }","duration":"204.933735ms","start":"2026-05-26T14:10:04.970941Z","end":"2026-05-26T14:10:05.175875Z","steps":["trace[961718241] 'agreement among raft nodes before linearized reading' (duration: 204.826712ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:10:05.175805Z","caller":"traceutil/trace.go:171","msg":"trace[1922245669] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8j77d; range_end:; response_count:1; response_revision:11477; }","duration":"173.570503ms","start":"2026-05-26T14:10:05.002218Z","end":"2026-05-26T14:10:05.175789Z","steps":["trace[1922245669] 'agreement among raft nodes before linearized reading' (duration: 173.427729ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:10:05.175733Z","caller":"traceutil/trace.go:171","msg":"trace[833203020] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:11477; }","duration":"205.186973ms","start":"2026-05-26T14:10:04.970447Z","end":"2026-05-26T14:10:05.175634Z","steps":["trace[833203020] 'agreement among raft nodes before linearized reading' (duration: 205.07626ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:10:05.175916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.411703ms","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-05-26T14:10:05.175878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.029088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T14:10:05.175731Z","caller":"traceutil/trace.go:171","msg":"trace[697568730] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:11477; }","duration":"207.66336ms","start":"2026-05-26T14:10:04.96806Z","end":"2026-05-26T14:10:05.175723Z","steps":["trace[697568730] 'agreement among raft nodes before linearized reading' (duration: 207.607629ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:10:05.175956Z","caller":"traceutil/trace.go:171","msg":"trace[497182699] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:11477; }","duration":"195.453275ms","start":"2026-05-26T14:10:04.980487Z","end":"2026-05-26T14:10:05.17594Z","steps":["trace[497182699] 'agreement among raft nodes before linearized reading' (duration: 195.319572ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:10:05.175878Z","caller":"traceutil/trace.go:171","msg":"trace[178353272] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:11477; }","duration":"204.976637ms","start":"2026-05-26T14:10:04.970879Z","end":"2026-05-26T14:10:05.175856Z","steps":["trace[178353272] 'agreement among raft nodes before linearized reading' (duration: 204.72395ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:10:05.176047Z","caller":"traceutil/trace.go:171","msg":"trace[314856209] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:11477; }","duration":"205.192702ms","start":"2026-05-26T14:10:04.970784Z","end":"2026-05-26T14:10:05.175977Z","steps":["trace[314856209] 'agreement among raft nodes before linearized reading' (duration: 204.971586ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:10:05.176243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.447604ms","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-26T14:10:05.1763Z","caller":"traceutil/trace.go:171","msg":"trace[1592234559] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:11477; }","duration":"127.538867ms","start":"2026-05-26T14:10:05.048746Z","end":"2026-05-26T14:10:05.176285Z","steps":["trace[1592234559] 'agreement among raft nodes before linearized reading' (duration: 127.30927ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:10:05.546887Z","caller":"traceutil/trace.go:171","msg":"trace[1729655433] transaction","detail":"{read_only:false; response_revision:11483; number_of_response:1; }","duration":"113.731478ms","start":"2026-05-26T14:10:05.433132Z","end":"2026-05-26T14:10:05.546863Z","steps":["trace[1729655433] 'process raft request' (duration: 113.584364ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:13:25.000936Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10518} {"level":"info","ts":"2026-05-26T14:13:25.082143Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10518,"took":"78.771526ms","hash":4208998270,"current-db-size-bytes":56995840,"current-db-size":"57 MB","current-db-size-in-use-bytes":27521024,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-05-26T14:13:25.082202Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4208998270,"revision":10518,"compact-revision":8062} {"level":"warn","ts":"2026-05-26T14:17:59.955063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.385291ms","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-05-26T14:17:59.955179Z","caller":"traceutil/trace.go:171","msg":"trace[2071873156] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15086; }","duration":"103.575816ms","start":"2026-05-26T14:17:59.85158Z","end":"2026-05-26T14:17:59.955156Z","steps":["trace[2071873156] 'range keys from in-memory index tree' (duration: 103.170975ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:17:59.955272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.005502ms","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-05-26T14:17:59.955354Z","caller":"traceutil/trace.go:171","msg":"trace[1000809461] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:15086; }","duration":"102.160207ms","start":"2026-05-26T14:17:59.853176Z","end":"2026-05-26T14:17:59.955336Z","steps":["trace[1000809461] 'range keys from in-memory index tree' (duration: 101.770056ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:18:25.006835Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12771} {"level":"info","ts":"2026-05-26T14:18:25.087189Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12771,"took":"77.718573ms","hash":4180022900,"current-db-size-bytes":56995840,"current-db-size":"57 MB","current-db-size-in-use-bytes":30191616,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-26T14:18:25.087252Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4180022900,"revision":12771,"compact-revision":10518} {"level":"warn","ts":"2026-05-26T14:19:36.199641Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305496303781850381,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-26T14:19:36.690206Z","caller":"traceutil/trace.go:171","msg":"trace[111963724] transaction","detail":"{read_only:false; response_revision:15670; number_of_response:1; }","duration":"998.03665ms","start":"2026-05-26T14:19:35.692151Z","end":"2026-05-26T14:19:36.690188Z","steps":["trace[111963724] 'process raft request' (duration: 997.893176ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:36.690335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:35.692124Z","time spent":"998.150563ms","remote":"127.0.0.1:43354","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":875,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T14:19:36.734993Z","caller":"traceutil/trace.go:171","msg":"trace[1908318362] linearizableReadLoop","detail":"{readStateIndex:16212; appliedIndex:16210; }","duration":"1.035411192s","start":"2026-05-26T14:19:35.69956Z","end":"2026-05-26T14:19:36.734971Z","steps":["trace[1908318362] 'read index received' (duration: 990.490362ms)","trace[1908318362] 'applied index is now lower than readState.Index' (duration: 44.91994ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T14:19:36.735024Z","caller":"traceutil/trace.go:171","msg":"trace[1256235342] transaction","detail":"{read_only:false; response_revision:15671; number_of_response:1; }","duration":"1.032118981s","start":"2026-05-26T14:19:35.702868Z","end":"2026-05-26T14:19:36.734987Z","steps":["trace[1256235342] 'process raft request' (duration: 1.031916496s)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:19:36.735105Z","caller":"traceutil/trace.go:171","msg":"trace[739885007] transaction","detail":"{read_only:false; response_revision:15672; number_of_response:1; }","duration":"236.081845ms","start":"2026-05-26T14:19:36.499015Z","end":"2026-05-26T14:19:36.735096Z","steps":["trace[739885007] 'process raft request' (duration: 235.911791ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:36.735157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:35.702841Z","time spent":"1.032246904s","remote":"127.0.0.1:43444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14950,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T14:19:36.735293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.03572175s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-xpg8p\" ","response":"range_response_count:1 size:9788"} {"level":"info","ts":"2026-05-26T14:19:36.735318Z","caller":"traceutil/trace.go:171","msg":"trace[568386635] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-xpg8p; range_end:; response_count:1; response_revision:15672; }","duration":"1.035795992s","start":"2026-05-26T14:19:35.699513Z","end":"2026-05-26T14:19:36.735309Z","steps":["trace[568386635] 'agreement among raft nodes before linearized reading' (duration: 1.035691369s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:36.735337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:35.699494Z","time spent":"1.035837674s","remote":"127.0.0.1:43444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":9811,"request content":"key:\"/registry/pods/openstack/nova-cell-setup-xpg8p\" "} {"level":"warn","ts":"2026-05-26T14:19:36.73539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"954.646573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-k2vrr\" ","response":"range_response_count:1 size:22100"} {"level":"info","ts":"2026-05-26T14:19:36.73543Z","caller":"traceutil/trace.go:171","msg":"trace[2082450473] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-k2vrr; range_end:; response_count:1; response_revision:15672; }","duration":"954.720515ms","start":"2026-05-26T14:19:35.780697Z","end":"2026-05-26T14:19:36.735417Z","steps":["trace[2082450473] 'agreement among raft nodes before linearized reading' (duration: 954.575381ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:36.73546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:35.780681Z","time spent":"954.771636ms","remote":"127.0.0.1:43444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22123,"request content":"key:\"/registry/pods/openstack/nova-compute-default-k2vrr\" "} {"level":"warn","ts":"2026-05-26T14:19:36.735527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.55737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-05-26T14:19:36.735539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"786.452862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-k2vrr\" ","response":"range_response_count:1 size:22100"} {"level":"info","ts":"2026-05-26T14:19:36.735565Z","caller":"traceutil/trace.go:171","msg":"trace[72909960] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:15672; }","duration":"256.619372ms","start":"2026-05-26T14:19:36.478935Z","end":"2026-05-26T14:19:36.735555Z","steps":["trace[72909960] 'agreement among raft nodes before linearized reading' (duration: 256.528209ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:19:36.735613Z","caller":"traceutil/trace.go:171","msg":"trace[2026747537] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-k2vrr; range_end:; response_count:1; response_revision:15672; }","duration":"786.563545ms","start":"2026-05-26T14:19:35.949031Z","end":"2026-05-26T14:19:36.735595Z","steps":["trace[2026747537] 'agreement among raft nodes before linearized reading' (duration: 786.37461ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:36.735621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.160713ms","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-05-26T14:19:36.735647Z","caller":"traceutil/trace.go:171","msg":"trace[807441913] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:15672; }","duration":"283.218525ms","start":"2026-05-26T14:19:36.452421Z","end":"2026-05-26T14:19:36.73564Z","steps":["trace[807441913] 'agreement among raft nodes before linearized reading' (duration: 283.148183ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:36.73565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:35.949015Z","time spent":"786.626516ms","remote":"127.0.0.1:43444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22123,"request content":"key:\"/registry/pods/openstack/nova-compute-default-k2vrr\" "} {"level":"warn","ts":"2026-05-26T14:19:36.735741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.138755ms","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-05-26T14:19:36.735759Z","caller":"traceutil/trace.go:171","msg":"trace[1098885874] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15672; }","duration":"274.156435ms","start":"2026-05-26T14:19:36.461597Z","end":"2026-05-26T14:19:36.735753Z","steps":["trace[1098885874] 'agreement among raft nodes before linearized reading' (duration: 274.102124ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:36.735782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"807.656087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-05-26T14:19:36.735819Z","caller":"traceutil/trace.go:171","msg":"trace[1270445507] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:15672; }","duration":"807.718719ms","start":"2026-05-26T14:19:35.92809Z","end":"2026-05-26T14:19:36.735809Z","steps":["trace[1270445507] 'agreement among raft nodes before linearized reading' (duration: 807.622136ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:36.735844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:35.928079Z","time spent":"807.75869ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":553,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"warn","ts":"2026-05-26T14:19:36.73587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.125009ms","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-05-26T14:19:36.735919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"822.96852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8j77d\" ","response":"range_response_count:1 size:6530"} {"level":"warn","ts":"2026-05-26T14:19:36.73592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.155299ms","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-26T14:19:36.73594Z","caller":"traceutil/trace.go:171","msg":"trace[1067439441] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8j77d; range_end:; response_count:1; response_revision:15672; }","duration":"823.041551ms","start":"2026-05-26T14:19:35.912892Z","end":"2026-05-26T14:19:36.735934Z","steps":["trace[1067439441] 'agreement among raft nodes before linearized reading' (duration: 823.00423ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:19:36.735951Z","caller":"traceutil/trace.go:171","msg":"trace[521788940] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:15672; }","duration":"256.209181ms","start":"2026-05-26T14:19:36.479734Z","end":"2026-05-26T14:19:36.735943Z","steps":["trace[521788940] 'agreement among raft nodes before linearized reading' (duration: 256.139909ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:36.735958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:35.912867Z","time spent":"823.086903ms","remote":"127.0.0.1:43444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6553,"request content":"key:\"/registry/pods/openstack/keepalived-8j77d\" "} {"level":"warn","ts":"2026-05-26T14:19:36.736018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"955.204118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:666"} {"level":"info","ts":"2026-05-26T14:19:36.736037Z","caller":"traceutil/trace.go:171","msg":"trace[916011007] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15672; }","duration":"955.25392ms","start":"2026-05-26T14:19:35.780778Z","end":"2026-05-26T14:19:36.736032Z","steps":["trace[916011007] 'agreement among raft nodes before linearized reading' (duration: 955.199418ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:36.736055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:35.780764Z","time spent":"955.287421ms","remote":"127.0.0.1:43434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":689,"request content":"key:\"/registry/services/endpoints/openstack/nova-api\" "} {"level":"info","ts":"2026-05-26T14:19:36.735923Z","caller":"traceutil/trace.go:171","msg":"trace[2034834290] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:15672; }","duration":"517.224302ms","start":"2026-05-26T14:19:36.21869Z","end":"2026-05-26T14:19:36.735914Z","steps":["trace[2034834290] 'agreement among raft nodes before linearized reading' (duration: 517.107119ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:36.736073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"898.391051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:666"} {"level":"info","ts":"2026-05-26T14:19:36.736092Z","caller":"traceutil/trace.go:171","msg":"trace[1802948970] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15672; }","duration":"898.449842ms","start":"2026-05-26T14:19:35.837637Z","end":"2026-05-26T14:19:36.736087Z","steps":["trace[1802948970] 'agreement among raft nodes before linearized reading' (duration: 898.396001ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:36.736092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:36.21867Z","time spent":"517.408197ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-26T14:19:36.73611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:35.837617Z","time spent":"898.488583ms","remote":"127.0.0.1:43434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":689,"request content":"key:\"/registry/services/endpoints/openstack/nova-api\" "} {"level":"warn","ts":"2026-05-26T14:19:36.736147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"932.760379ms","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-26T14:19:36.736162Z","caller":"traceutil/trace.go:171","msg":"trace[703162258] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:15672; }","duration":"932.779099ms","start":"2026-05-26T14:19:35.803379Z","end":"2026-05-26T14:19:36.736158Z","steps":["trace[703162258] 'agreement among raft nodes before linearized reading' (duration: 932.749729ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:36.736175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:35.803362Z","time spent":"932.809411ms","remote":"127.0.0.1:43358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-05-26T14:19:36.736236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"832.358868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-nf4xx\" ","response":"range_response_count:1 size:20754"} {"level":"info","ts":"2026-05-26T14:19:36.736256Z","caller":"traceutil/trace.go:171","msg":"trace[1627066157] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-nf4xx; range_end:; response_count:1; response_revision:15672; }","duration":"832.41663ms","start":"2026-05-26T14:19:35.903834Z","end":"2026-05-26T14:19:36.736251Z","steps":["trace[1627066157] 'agreement among raft nodes before linearized reading' (duration: 832.369429ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:36.736276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:35.903814Z","time spent":"832.455781ms","remote":"127.0.0.1:43444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":20777,"request content":"key:\"/registry/pods/openstack/libvirt-libvirt-default-nf4xx\" "} {"level":"warn","ts":"2026-05-26T14:19:51.81699Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.858426062s","expected-duration":"1s"} {"level":"info","ts":"2026-05-26T14:19:51.817329Z","caller":"traceutil/trace.go:171","msg":"trace[2104677458] linearizableReadLoop","detail":"{readStateIndex:16307; appliedIndex:16306; }","duration":"1.856980352s","start":"2026-05-26T14:19:49.96033Z","end":"2026-05-26T14:19:51.81731Z","steps":["trace[2104677458] 'read index received' (duration: 1.856794357s)","trace[2104677458] 'applied index is now lower than readState.Index' (duration: 185.465µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T14:19:51.817502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.857142136s","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-05-26T14:19:51.817525Z","caller":"traceutil/trace.go:171","msg":"trace[544129698] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:15763; }","duration":"1.857195998s","start":"2026-05-26T14:19:49.960323Z","end":"2026-05-26T14:19:51.817519Z","steps":["trace[544129698] 'agreement among raft nodes before linearized reading' (duration: 1.857037913s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:51.817547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:49.960275Z","time spent":"1.857267299s","remote":"127.0.0.1:43444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-05-26T14:19:51.817804Z","caller":"traceutil/trace.go:171","msg":"trace[372820972] transaction","detail":"{read_only:false; response_revision:15763; number_of_response:1; }","duration":"1.859354967s","start":"2026-05-26T14:19:49.95843Z","end":"2026-05-26T14:19:51.817785Z","steps":["trace[372820972] 'process raft request' (duration: 1.858763191s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:51.817864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:49.958404Z","time spent":"1.859419439s","remote":"127.0.0.1:43444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15431,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T14:19:52.326983Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305496303781850733,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-26T14:19:52.782718Z","caller":"traceutil/trace.go:171","msg":"trace[330074127] transaction","detail":"{read_only:false; response_revision:15764; number_of_response:1; }","duration":"956.047826ms","start":"2026-05-26T14:19:51.826641Z","end":"2026-05-26T14:19:52.782689Z","steps":["trace[330074127] 'process raft request' (duration: 954.447622ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:52.782889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:51.826613Z","time spent":"956.18693ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T14:19:52.787629Z","caller":"traceutil/trace.go:171","msg":"trace[560299108] transaction","detail":"{read_only:false; response_revision:15766; number_of_response:1; }","duration":"960.813678ms","start":"2026-05-26T14:19:51.826792Z","end":"2026-05-26T14:19:52.787605Z","steps":["trace[560299108] 'process raft request' (duration: 960.752776ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:19:52.787634Z","caller":"traceutil/trace.go:171","msg":"trace[1586096734] transaction","detail":"{read_only:false; response_revision:15765; number_of_response:1; }","duration":"960.862029ms","start":"2026-05-26T14:19:51.826745Z","end":"2026-05-26T14:19:52.787607Z","steps":["trace[1586096734] 'process raft request' (duration: 960.674333ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:52.787766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:51.826785Z","time spent":"960.91321ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T14:19:52.787846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:51.826731Z","time spent":"961.059275ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T14:19:52.78787Z","caller":"traceutil/trace.go:171","msg":"trace[1632299404] linearizableReadLoop","detail":"{readStateIndex:16312; appliedIndex:16307; }","duration":"961.099405ms","start":"2026-05-26T14:19:51.826751Z","end":"2026-05-26T14:19:52.787851Z","steps":["trace[1632299404] 'read index received' (duration: 954.422991ms)","trace[1632299404] 'applied index is now lower than readState.Index' (duration: 6.675864ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T14:19:52.788003Z","caller":"traceutil/trace.go:171","msg":"trace[814235022] transaction","detail":"{read_only:false; response_revision:15767; number_of_response:1; }","duration":"961.195748ms","start":"2026-05-26T14:19:51.826798Z","end":"2026-05-26T14:19:52.787994Z","steps":["trace[814235022] 'process raft request' (duration: 960.772557ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:52.788083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"961.26861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"warn","ts":"2026-05-26T14:19:52.788094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:51.826783Z","time spent":"961.249079ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T14:19:52.788023Z","caller":"traceutil/trace.go:171","msg":"trace[515574222] transaction","detail":"{read_only:false; response_revision:15768; number_of_response:1; }","duration":"953.683021ms","start":"2026-05-26T14:19:51.834273Z","end":"2026-05-26T14:19:52.787956Z","steps":["trace[515574222] 'process raft request' (duration: 953.475805ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:19:52.788115Z","caller":"traceutil/trace.go:171","msg":"trace[431935834] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:15768; }","duration":"961.364682ms","start":"2026-05-26T14:19:51.826739Z","end":"2026-05-26T14:19:52.788104Z","steps":["trace[431935834] 'agreement among raft nodes before linearized reading' (duration: 961.212948ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:52.788138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:51.826732Z","time spent":"961.400864ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":581,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-05-26T14:19:52.788369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"895.976572ms","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-05-26T14:19:52.788389Z","caller":"traceutil/trace.go:171","msg":"trace[1581731584] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:15768; }","duration":"896.008253ms","start":"2026-05-26T14:19:51.892377Z","end":"2026-05-26T14:19:52.788385Z","steps":["trace[1581731584] 'agreement among raft nodes before linearized reading' (duration: 895.943781ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:52.788403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:51.892373Z","time spent":"896.027003ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-26T14:19:52.788411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"958.01695ms","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-05-26T14:19:52.788481Z","caller":"traceutil/trace.go:171","msg":"trace[2015487785] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15768; }","duration":"958.120793ms","start":"2026-05-26T14:19:51.830344Z","end":"2026-05-26T14:19:52.788465Z","steps":["trace[2015487785] 'agreement among raft nodes before linearized reading' (duration: 957.951449ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:52.788471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"873.617657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:666"} {"level":"warn","ts":"2026-05-26T14:19:52.788524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:51.829904Z","time spent":"958.611937ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-26T14:19:52.788512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"896.148257ms","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-26T14:19:52.788536Z","caller":"traceutil/trace.go:171","msg":"trace[1499718568] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15768; }","duration":"873.705889ms","start":"2026-05-26T14:19:51.914812Z","end":"2026-05-26T14:19:52.788518Z","steps":["trace[1499718568] 'agreement among raft nodes before linearized reading' (duration: 873.510723ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:52.78857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"882.205853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T14:19:52.788567Z","caller":"traceutil/trace.go:171","msg":"trace[1384951178] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:15768; }","duration":"896.228409ms","start":"2026-05-26T14:19:51.892327Z","end":"2026-05-26T14:19:52.788556Z","steps":["trace[1384951178] 'agreement among raft nodes before linearized reading' (duration: 896.134666ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:19:52.788591Z","caller":"traceutil/trace.go:171","msg":"trace[875160811] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:15768; }","duration":"882.247985ms","start":"2026-05-26T14:19:51.906339Z","end":"2026-05-26T14:19:52.788587Z","steps":["trace[875160811] 'agreement among raft nodes before linearized reading' (duration: 882.207123ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:52.788581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:51.914806Z","time spent":"873.76369ms","remote":"127.0.0.1:43434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":689,"request content":"key:\"/registry/services/endpoints/openstack/nova-api\" "} {"level":"warn","ts":"2026-05-26T14:19:52.788608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:51.906332Z","time spent":"882.272645ms","remote":"127.0.0.1:43694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-05-26T14:19:52.788607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:51.892313Z","time spent":"896.284621ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-26T14:19:52.788596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"958.547035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-metadata\" ","response":"range_response_count:1 size:682"} {"level":"warn","ts":"2026-05-26T14:19:52.788575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"859.829257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"warn","ts":"2026-05-26T14:19:52.788438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"940.043256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"warn","ts":"2026-05-26T14:19:52.788716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"957.808105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T14:19:52.788719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"958.607967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T14:19:52.788777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"949.557328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T14:19:52.78881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"954.281438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:666"} {"level":"info","ts":"2026-05-26T14:19:52.788821Z","caller":"traceutil/trace.go:171","msg":"trace[1317238877] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15768; }","duration":"949.614239ms","start":"2026-05-26T14:19:51.839197Z","end":"2026-05-26T14:19:52.788812Z","steps":["trace[1317238877] 'agreement among raft nodes before linearized reading' (duration: 949.548977ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:19:52.788831Z","caller":"traceutil/trace.go:171","msg":"trace[1320848793] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15768; }","duration":"954.303158ms","start":"2026-05-26T14:19:51.834522Z","end":"2026-05-26T14:19:52.788825Z","steps":["trace[1320848793] 'agreement among raft nodes before linearized reading' (duration: 954.235366ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:52.788857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"957.897657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-05-26T14:19:52.788867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:51.834469Z","time spent":"954.391721ms","remote":"127.0.0.1:43434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":689,"request content":"key:\"/registry/services/endpoints/openstack/nova-api\" "} {"level":"warn","ts":"2026-05-26T14:19:52.788836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"957.9902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:1 size:12595"} {"level":"info","ts":"2026-05-26T14:19:52.788878Z","caller":"traceutil/trace.go:171","msg":"trace[1790948556] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:15768; }","duration":"957.934758ms","start":"2026-05-26T14:19:51.830938Z","end":"2026-05-26T14:19:52.788872Z","steps":["trace[1790948556] 'agreement among raft nodes before linearized reading' (duration: 957.867967ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:52.788893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.096809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T14:19:52.788907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:51.830932Z","time spent":"957.971829ms","remote":"127.0.0.1:43508","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-05-26T14:19:52.788925Z","caller":"traceutil/trace.go:171","msg":"trace[1592881120] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:15768; }","duration":"221.15867ms","start":"2026-05-26T14:19:52.567757Z","end":"2026-05-26T14:19:52.788916Z","steps":["trace[1592881120] 'agreement among raft nodes before linearized reading' (duration: 221.097718ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:19:52.78874Z","caller":"traceutil/trace.go:171","msg":"trace[1344426075] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:15768; }","duration":"957.840356ms","start":"2026-05-26T14:19:51.830892Z","end":"2026-05-26T14:19:52.788732Z","steps":["trace[1344426075] 'agreement among raft nodes before linearized reading' (duration: 957.797964ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:19:52.788922Z","caller":"traceutil/trace.go:171","msg":"trace[1838472506] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:1; response_revision:15768; }","duration":"958.130553ms","start":"2026-05-26T14:19:51.830771Z","end":"2026-05-26T14:19:52.788901Z","steps":["trace[1838472506] 'agreement among raft nodes before linearized reading' (duration: 957.965149ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:52.788942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"961.837056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-nf4xx\" ","response":"range_response_count:1 size:20754"} {"level":"warn","ts":"2026-05-26T14:19:52.788956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:51.830887Z","time spent":"958.065612ms","remote":"127.0.0.1:43488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/nova-ks-user\" "} {"level":"warn","ts":"2026-05-26T14:19:52.788964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.26982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-ks-endpoints-6dnz2\" ","response":"range_response_count:1 size:15446"} {"level":"info","ts":"2026-05-26T14:19:52.788775Z","caller":"traceutil/trace.go:171","msg":"trace[21476257] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:0; response_revision:15768; }","duration":"958.683489ms","start":"2026-05-26T14:19:51.830078Z","end":"2026-05-26T14:19:52.788761Z","steps":["trace[21476257] 'agreement among raft nodes before linearized reading' (duration: 958.609397ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:19:52.788973Z","caller":"traceutil/trace.go:171","msg":"trace[1905469076] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-nf4xx; range_end:; response_count:1; response_revision:15768; }","duration":"961.874397ms","start":"2026-05-26T14:19:51.82709Z","end":"2026-05-26T14:19:52.788964Z","steps":["trace[1905469076] 'agreement among raft nodes before linearized reading' (duration: 961.815735ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:19:52.788983Z","caller":"traceutil/trace.go:171","msg":"trace[297425236] range","detail":"{range_begin:/registry/pods/openstack/nova-ks-endpoints-6dnz2; range_end:; response_count:1; response_revision:15768; }","duration":"340.318101ms","start":"2026-05-26T14:19:52.44866Z","end":"2026-05-26T14:19:52.788978Z","steps":["trace[297425236] 'agreement among raft nodes before linearized reading' (duration: 340.25463ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:52.788976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:51.830755Z","time spent":"958.210786ms","remote":"127.0.0.1:43488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":12618,"request content":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" "} {"level":"warn","ts":"2026-05-26T14:19:52.789001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:51.827085Z","time spent":"961.908808ms","remote":"127.0.0.1:43444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":20777,"request content":"key:\"/registry/pods/openstack/libvirt-libvirt-default-nf4xx\" "} {"level":"warn","ts":"2026-05-26T14:19:52.789001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:51.830066Z","time spent":"958.925016ms","remote":"127.0.0.1:43434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":0,"response size":28,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "} {"level":"warn","ts":"2026-05-26T14:19:52.788998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"958.081282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-xpg8p\" ","response":"range_response_count:1 size:9788"} {"level":"warn","ts":"2026-05-26T14:19:52.789009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:52.448642Z","time spent":"340.361602ms","remote":"127.0.0.1:43444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":15469,"request content":"key:\"/registry/pods/openstack/nova-ks-endpoints-6dnz2\" "} {"level":"info","ts":"2026-05-26T14:19:52.789038Z","caller":"traceutil/trace.go:171","msg":"trace[767162483] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:15768; }","duration":"940.665072ms","start":"2026-05-26T14:19:51.848347Z","end":"2026-05-26T14:19:52.789012Z","steps":["trace[767162483] 'agreement among raft nodes before linearized reading' (duration: 939.977023ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:19:52.789044Z","caller":"traceutil/trace.go:171","msg":"trace[4798664] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-xpg8p; range_end:; response_count:1; response_revision:15768; }","duration":"958.143824ms","start":"2026-05-26T14:19:51.830888Z","end":"2026-05-26T14:19:52.789032Z","steps":["trace[4798664] 'agreement among raft nodes before linearized reading' (duration: 958.01158ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:52.788976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"958.957456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:666"} {"level":"warn","ts":"2026-05-26T14:19:52.789075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:51.830881Z","time spent":"958.186565ms","remote":"127.0.0.1:43444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":9811,"request content":"key:\"/registry/pods/openstack/nova-cell-setup-xpg8p\" "} {"level":"info","ts":"2026-05-26T14:19:52.788828Z","caller":"traceutil/trace.go:171","msg":"trace[1058452873] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:15768; }","duration":"860.088854ms","start":"2026-05-26T14:19:51.928722Z","end":"2026-05-26T14:19:52.788811Z","steps":["trace[1058452873] 'agreement among raft nodes before linearized reading' (duration: 859.58248ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:52.788841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:51.83919Z","time spent":"949.64553ms","remote":"127.0.0.1:43270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-26T14:19:52.789126Z","caller":"traceutil/trace.go:171","msg":"trace[1499788747] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15768; }","duration":"959.10138ms","start":"2026-05-26T14:19:51.829987Z","end":"2026-05-26T14:19:52.789088Z","steps":["trace[1499788747] 'agreement among raft nodes before linearized reading' (duration: 958.765531ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:52.789125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:51.928712Z","time spent":"860.399862ms","remote":"127.0.0.1:43426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1958,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"warn","ts":"2026-05-26T14:19:52.788874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"958.774001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-k2vrr\" ","response":"range_response_count:1 size:22100"} {"level":"warn","ts":"2026-05-26T14:19:52.789145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:51.829978Z","time spent":"959.162592ms","remote":"127.0.0.1:43434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":689,"request content":"key:\"/registry/services/endpoints/openstack/nova-api\" "} {"level":"warn","ts":"2026-05-26T14:19:52.789239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.547169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:1 size:12595"} {"level":"info","ts":"2026-05-26T14:19:52.78866Z","caller":"traceutil/trace.go:171","msg":"trace[1973467103] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-metadata; range_end:; response_count:1; response_revision:15768; }","duration":"958.615537ms","start":"2026-05-26T14:19:51.830024Z","end":"2026-05-26T14:19:52.78864Z","steps":["trace[1973467103] 'agreement among raft nodes before linearized reading' (duration: 958.458213ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:19:52.789276Z","caller":"traceutil/trace.go:171","msg":"trace[1613231369] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:1; response_revision:15768; }","duration":"388.611731ms","start":"2026-05-26T14:19:52.400657Z","end":"2026-05-26T14:19:52.789268Z","steps":["trace[1613231369] 'agreement among raft nodes before linearized reading' (duration: 388.542049ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:52.789294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:51.83002Z","time spent":"959.265255ms","remote":"127.0.0.1:43434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":705,"request content":"key:\"/registry/services/endpoints/openstack/nova-metadata\" "} {"level":"warn","ts":"2026-05-26T14:19:52.789304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:52.40064Z","time spent":"388.656872ms","remote":"127.0.0.1:43488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":12618,"request content":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" "} {"level":"warn","ts":"2026-05-26T14:19:52.788901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.47273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T14:19:52.789332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"959.302976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"warn","ts":"2026-05-26T14:19:52.78934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"951.890302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:79 size:768210"} {"level":"info","ts":"2026-05-26T14:19:52.789371Z","caller":"traceutil/trace.go:171","msg":"trace[327235821] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:15768; }","duration":"959.346717ms","start":"2026-05-26T14:19:51.83001Z","end":"2026-05-26T14:19:52.789356Z","steps":["trace[327235821] 'agreement among raft nodes before linearized reading' (duration: 959.218653ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:19:52.789421Z","caller":"traceutil/trace.go:171","msg":"trace[1732561389] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:79; response_revision:15768; }","duration":"952.002725ms","start":"2026-05-26T14:19:51.837405Z","end":"2026-05-26T14:19:52.789408Z","steps":["trace[1732561389] 'agreement among raft nodes before linearized reading' (duration: 950.779161ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:52.789434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:51.830004Z","time spent":"959.42271ms","remote":"127.0.0.1:43444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-05-26T14:19:52.789489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:51.837394Z","time spent":"952.053216ms","remote":"127.0.0.1:43444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":79,"response size":768233,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"warn","ts":"2026-05-26T14:19:52.789498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:51.834255Z","time spent":"953.873867ms","remote":"127.0.0.1:43488","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12580,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T14:19:52.789165Z","caller":"traceutil/trace.go:171","msg":"trace[336112404] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-k2vrr; range_end:; response_count:1; response_revision:15768; }","duration":"959.07785ms","start":"2026-05-26T14:19:51.830077Z","end":"2026-05-26T14:19:52.789155Z","steps":["trace[336112404] 'agreement among raft nodes before linearized reading' (duration: 958.72405ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:52.78961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:51.830071Z","time spent":"959.530262ms","remote":"127.0.0.1:43444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22123,"request content":"key:\"/registry/pods/openstack/nova-compute-default-k2vrr\" "} {"level":"info","ts":"2026-05-26T14:19:52.789355Z","caller":"traceutil/trace.go:171","msg":"trace[220398583] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:15768; }","duration":"387.928432ms","start":"2026-05-26T14:19:52.401414Z","end":"2026-05-26T14:19:52.789343Z","steps":["trace[220398583] 'agreement among raft nodes before linearized reading' (duration: 387.47267ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:52.789684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:52.401409Z","time spent":"388.268522ms","remote":"127.0.0.1:43488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/nova-ks-user\" "} {"level":"warn","ts":"2026-05-26T14:19:52.789162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"777.961672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T14:19:52.789735Z","caller":"traceutil/trace.go:171","msg":"trace[491025354] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:15768; }","duration":"778.59717ms","start":"2026-05-26T14:19:52.011125Z","end":"2026-05-26T14:19:52.789722Z","steps":["trace[491025354] 'agreement among raft nodes before linearized reading' (duration: 777.955562ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:52.789774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:52.011104Z","time spent":"778.658472ms","remote":"127.0.0.1:39554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-26T14:19:52.789226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:51.848332Z","time spent":"940.777946ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":553,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"warn","ts":"2026-05-26T14:19:52.789222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"954.630077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:79 size:768210"} {"level":"info","ts":"2026-05-26T14:19:52.789853Z","caller":"traceutil/trace.go:171","msg":"trace[85371542] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:79; response_revision:15768; }","duration":"955.277615ms","start":"2026-05-26T14:19:51.834556Z","end":"2026-05-26T14:19:52.789833Z","steps":["trace[85371542] 'agreement among raft nodes before linearized reading' (duration: 954.085592ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:52.789972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:51.834542Z","time spent":"955.358138ms","remote":"127.0.0.1:43444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":79,"response size":768233,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"warn","ts":"2026-05-26T14:19:52.789589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"962.810013ms","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-05-26T14:19:52.790067Z","caller":"traceutil/trace.go:171","msg":"trace[1853092696] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:15768; }","duration":"963.322127ms","start":"2026-05-26T14:19:51.826734Z","end":"2026-05-26T14:19:52.790056Z","steps":["trace[1853092696] 'agreement among raft nodes before linearized reading' (duration: 961.443375ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:19:52.790091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:19:51.826718Z","time spent":"963.363088ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-26T14:23:25.013448Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15223} {"level":"info","ts":"2026-05-26T14:23:25.111168Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15223,"took":"95.29256ms","hash":4208176546,"current-db-size-bytes":56995840,"current-db-size":"57 MB","current-db-size-in-use-bytes":31744000,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-05-26T14:23:25.111259Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4208176546,"revision":15223,"compact-revision":12771} {"level":"warn","ts":"2026-05-26T14:23:42.417145Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305496303781857567,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-26T14:23:42.89482Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.11553332s","expected-duration":"1s"} {"level":"info","ts":"2026-05-26T14:23:42.89516Z","caller":"traceutil/trace.go:171","msg":"trace[563330992] linearizableReadLoop","detail":"{readStateIndex:18127; appliedIndex:18126; }","duration":"978.063447ms","start":"2026-05-26T14:23:41.917075Z","end":"2026-05-26T14:23:42.895139Z","steps":["trace[563330992] 'read index received' (duration: 977.876202ms)","trace[563330992] 'applied index is now lower than readState.Index' (duration: 186.625µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T14:23:42.895219Z","caller":"traceutil/trace.go:171","msg":"trace[41311291] transaction","detail":"{read_only:false; response_revision:17526; number_of_response:1; }","duration":"1.116056705s","start":"2026-05-26T14:23:41.779153Z","end":"2026-05-26T14:23:42.89521Z","steps":["trace[41311291] 'process raft request' (duration: 1.115857789s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:23:42.895301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:23:41.779131Z","time spent":"1.116107446s","remote":"127.0.0.1:43488","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7467,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T14:23:42.89548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.641027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:702"} {"level":"info","ts":"2026-05-26T14:23:42.895501Z","caller":"traceutil/trace.go:171","msg":"trace[1486100680] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:17526; }","duration":"511.662368ms","start":"2026-05-26T14:23:42.383832Z","end":"2026-05-26T14:23:42.895494Z","steps":["trace[1486100680] 'agreement among raft nodes before linearized reading' (duration: 511.561525ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:23:42.895518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:23:42.383777Z","time spent":"511.73752ms","remote":"127.0.0.1:43434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":725,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "} {"level":"warn","ts":"2026-05-26T14:23:42.895508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"964.726109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-05-26T14:23:42.895601Z","caller":"traceutil/trace.go:171","msg":"trace[1424232163] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:17526; }","duration":"964.878143ms","start":"2026-05-26T14:23:41.930695Z","end":"2026-05-26T14:23:42.895573Z","steps":["trace[1424232163] 'agreement among raft nodes before linearized reading' (duration: 964.624826ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:23:42.895658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:23:41.930675Z","time spent":"964.969226ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-26T14:23:42.895656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"883.701463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1936"} {"level":"warn","ts":"2026-05-26T14:23:42.89573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.443251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-26T14:23:42.895749Z","caller":"traceutil/trace.go:171","msg":"trace[1364205512] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17526; }","duration":"291.471492ms","start":"2026-05-26T14:23:42.604272Z","end":"2026-05-26T14:23:42.895743Z","steps":["trace[1364205512] 'agreement among raft nodes before linearized reading' (duration: 291.441432ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:23:42.895752Z","caller":"traceutil/trace.go:171","msg":"trace[1922335864] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:17526; }","duration":"883.849867ms","start":"2026-05-26T14:23:42.011878Z","end":"2026-05-26T14:23:42.895728Z","steps":["trace[1922335864] 'agreement among raft nodes before linearized reading' (duration: 883.570869ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:23:42.895801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:23:42.011862Z","time spent":"883.92827ms","remote":"127.0.0.1:43426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1959,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"warn","ts":"2026-05-26T14:23:42.895877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.279961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:702"} {"level":"info","ts":"2026-05-26T14:23:42.895896Z","caller":"traceutil/trace.go:171","msg":"trace[1338160243] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:17526; }","duration":"339.319023ms","start":"2026-05-26T14:23:42.556571Z","end":"2026-05-26T14:23:42.89589Z","steps":["trace[1338160243] 'agreement among raft nodes before linearized reading' (duration: 339.268571ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:23:42.895911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:23:42.556559Z","time spent":"339.348133ms","remote":"127.0.0.1:43434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":725,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "} {"level":"warn","ts":"2026-05-26T14:23:42.895964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"945.830018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-05-26T14:23:42.895995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.837981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-05-26T14:23:42.89599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"946.730033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-05-26T14:23:42.89602Z","caller":"traceutil/trace.go:171","msg":"trace[269986615] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:17526; }","duration":"362.899613ms","start":"2026-05-26T14:23:42.533113Z","end":"2026-05-26T14:23:42.896013Z","steps":["trace[269986615] 'agreement among raft nodes before linearized reading' (duration: 362.860592ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:23:42.896038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:23:42.533098Z","time spent":"362.935114ms","remote":"127.0.0.1:39706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":31,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-05-26T14:23:42.896026Z","caller":"traceutil/trace.go:171","msg":"trace[583674197] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:17526; }","duration":"945.92092ms","start":"2026-05-26T14:23:41.950088Z","end":"2026-05-26T14:23:42.896009Z","steps":["trace[583674197] 'agreement among raft nodes before linearized reading' (duration: 945.770616ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:23:42.896038Z","caller":"traceutil/trace.go:171","msg":"trace[871816573] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:17526; }","duration":"946.809665ms","start":"2026-05-26T14:23:41.949213Z","end":"2026-05-26T14:23:42.896022Z","steps":["trace[871816573] 'agreement among raft nodes before linearized reading' (duration: 946.689272ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:23:42.89607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:23:41.950071Z","time spent":"945.987362ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-26T14:23:42.896078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:23:41.949198Z","time spent":"946.867226ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-26T14:23:42.896087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"679.121319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-26T14:23:42.89612Z","caller":"traceutil/trace.go:171","msg":"trace[1980742342] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:17526; }","duration":"679.188221ms","start":"2026-05-26T14:23:42.216922Z","end":"2026-05-26T14:23:42.896111Z","steps":["trace[1980742342] 'agreement among raft nodes before linearized reading' (duration: 679.128559ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:23:42.896149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:23:42.216908Z","time spent":"679.233682ms","remote":"127.0.0.1:56246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true "} {"level":"warn","ts":"2026-05-26T14:23:42.896166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.923651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:702"} {"level":"info","ts":"2026-05-26T14:23:42.896184Z","caller":"traceutil/trace.go:171","msg":"trace[378302178] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:17526; }","duration":"438.984643ms","start":"2026-05-26T14:23:42.457194Z","end":"2026-05-26T14:23:42.896179Z","steps":["trace[378302178] 'agreement among raft nodes before linearized reading' (duration: 438.930141ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:23:42.896198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:23:42.457167Z","time spent":"439.028144ms","remote":"127.0.0.1:43434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":725,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "} {"level":"warn","ts":"2026-05-26T14:23:42.896247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"945.774596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-26T14:23:42.896293Z","caller":"traceutil/trace.go:171","msg":"trace[1495610597] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:17526; }","duration":"945.857008ms","start":"2026-05-26T14:23:41.950422Z","end":"2026-05-26T14:23:42.896279Z","steps":["trace[1495610597] 'agreement among raft nodes before linearized reading' (duration: 945.736295ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:23:42.896315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.172557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:702"} {"level":"info","ts":"2026-05-26T14:23:42.896332Z","caller":"traceutil/trace.go:171","msg":"trace[80727190] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:17526; }","duration":"460.214949ms","start":"2026-05-26T14:23:42.436112Z","end":"2026-05-26T14:23:42.896327Z","steps":["trace[80727190] 'agreement among raft nodes before linearized reading' (duration: 460.153857ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:23:42.896331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:23:41.950402Z","time spent":"945.91836ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-26T14:23:42.896354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.72498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-05-26T14:23:42.896382Z","caller":"traceutil/trace.go:171","msg":"trace[306204952] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:17526; }","duration":"681.792722ms","start":"2026-05-26T14:23:42.214581Z","end":"2026-05-26T14:23:42.896374Z","steps":["trace[306204952] 'agreement among raft nodes before linearized reading' (duration: 681.695539ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:23:42.896407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:23:42.214548Z","time spent":"681.851354ms","remote":"127.0.0.1:43444","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-05-26T14:23:42.896348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:23:42.436097Z","time spent":"460.247389ms","remote":"127.0.0.1:43434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":725,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "} {"level":"warn","ts":"2026-05-26T14:23:42.895697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"978.627032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-05-26T14:23:42.896622Z","caller":"traceutil/trace.go:171","msg":"trace[635783329] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:17526; }","duration":"979.576629ms","start":"2026-05-26T14:23:41.917039Z","end":"2026-05-26T14:23:42.896616Z","steps":["trace[635783329] 'agreement among raft nodes before linearized reading' (duration: 978.613532ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:23:42.896643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:23:41.917024Z","time spent":"979.612849ms","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-26T14:28:25.019389Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17434} {"level":"info","ts":"2026-05-26T14:28:25.112354Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17434,"took":"89.737946ms","hash":3921634953,"current-db-size-bytes":56995840,"current-db-size":"57 MB","current-db-size-in-use-bytes":27611136,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-05-26T14:28:25.112484Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3921634953,"revision":17434,"compact-revision":15223} {"level":"warn","ts":"2026-05-26T14:28:31.098509Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305496303781864679,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-26T14:28:31.758406Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13305496303781864679,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-26T14:28:31.801385Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.481200391s","expected-duration":"1s"} {"level":"info","ts":"2026-05-26T14:28:31.802237Z","caller":"traceutil/trace.go:171","msg":"trace[1904232283] transaction","detail":"{read_only:false; response_revision:19114; number_of_response:1; }","duration":"1.482140717s","start":"2026-05-26T14:28:30.320075Z","end":"2026-05-26T14:28:31.802215Z","steps":["trace[1904232283] 'process raft request' (duration: 1.482005723s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:28:31.802365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:28:30.320049Z","time spent":"1.48225112s","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T14:28:31.80622Z","caller":"traceutil/trace.go:171","msg":"trace[1289732411] transaction","detail":"{read_only:false; response_revision:19116; number_of_response:1; }","duration":"1.485618613s","start":"2026-05-26T14:28:30.320585Z","end":"2026-05-26T14:28:31.806204Z","steps":["trace[1289732411] 'process raft request' (duration: 1.485534791s)"],"step_count":1} {"level":"info","ts":"2026-05-26T14:28:31.806242Z","caller":"traceutil/trace.go:171","msg":"trace[601821364] transaction","detail":"{read_only:false; response_revision:19115; number_of_response:1; }","duration":"1.485633264s","start":"2026-05-26T14:28:30.320568Z","end":"2026-05-26T14:28:31.806201Z","steps":["trace[601821364] 'process raft request' (duration: 1.485465089s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:28:31.806428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:28:30.320549Z","time spent":"1.485808708s","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T14:28:31.806309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:28:30.320564Z","time spent":"1.485698536s","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T14:28:31.806662Z","caller":"traceutil/trace.go:171","msg":"trace[926219886] transaction","detail":"{read_only:false; response_revision:19117; number_of_response:1; }","duration":"1.216338002s","start":"2026-05-26T14:28:30.590314Z","end":"2026-05-26T14:28:31.806652Z","steps":["trace[926219886] 'process raft request' (duration: 1.215833668s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:28:31.806712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:28:30.590293Z","time spent":"1.216393214s","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T14:28:31.806975Z","caller":"traceutil/trace.go:171","msg":"trace[15722065] transaction","detail":"{read_only:false; response_revision:19118; number_of_response:1; }","duration":"1.214349158s","start":"2026-05-26T14:28:30.592617Z","end":"2026-05-26T14:28:31.806966Z","steps":["trace[15722065] 'process raft request' (duration: 1.213558696s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:28:31.807062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:28:30.592588Z","time spent":"1.21441061s","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T14:28:31.807199Z","caller":"traceutil/trace.go:171","msg":"trace[735094722] transaction","detail":"{read_only:false; response_revision:19119; number_of_response:1; }","duration":"1.210112221s","start":"2026-05-26T14:28:30.597078Z","end":"2026-05-26T14:28:31.807191Z","steps":["trace[735094722] 'process raft request' (duration: 1.209546706s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:28:31.80724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:28:30.597055Z","time spent":"1.210165662s","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T14:28:31.80732Z","caller":"traceutil/trace.go:171","msg":"trace[1431722998] transaction","detail":"{read_only:false; response_revision:19120; number_of_response:1; }","duration":"1.210158902s","start":"2026-05-26T14:28:30.597151Z","end":"2026-05-26T14:28:31.80731Z","steps":["trace[1431722998] 'process raft request' (duration: 1.209787122s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:28:31.807398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:28:30.597118Z","time spent":"1.210247575s","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T14:28:31.807445Z","caller":"traceutil/trace.go:171","msg":"trace[1358108534] linearizableReadLoop","detail":"{readStateIndex:19787; appliedIndex:19779; }","duration":"1.484561214s","start":"2026-05-26T14:28:30.322853Z","end":"2026-05-26T14:28:31.807414Z","steps":["trace[1358108534] 'read index received' (duration: 1.479187096s)","trace[1358108534] 'applied index is now lower than readState.Index' (duration: 5.373148ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T14:28:31.807626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.48477752s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-05-26T14:28:31.807668Z","caller":"traceutil/trace.go:171","msg":"trace[1534586044] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:19121; }","duration":"1.484837661s","start":"2026-05-26T14:28:30.322823Z","end":"2026-05-26T14:28:31.807661Z","steps":["trace[1534586044] 'agreement among raft nodes before linearized reading' (duration: 1.484663766s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:28:31.807662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.484566864s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"warn","ts":"2026-05-26T14:28:31.807702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:28:30.322813Z","time spent":"1.484884453s","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-26T14:28:31.807713Z","caller":"traceutil/trace.go:171","msg":"trace[297123653] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:19121; }","duration":"1.484641626s","start":"2026-05-26T14:28:30.323055Z","end":"2026-05-26T14:28:31.807697Z","steps":["trace[297123653] 'agreement among raft nodes before linearized reading' (duration: 1.484492792s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:28:31.807745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:28:30.32305Z","time spent":"1.484685447s","remote":"127.0.0.1:43508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-26T14:28:31.80785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"841.122689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-k2vrr\" ","response":"range_response_count:1 size:22101"} {"level":"info","ts":"2026-05-26T14:28:31.80789Z","caller":"traceutil/trace.go:171","msg":"trace[442884377] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-k2vrr; range_end:; response_count:1; response_revision:19121; }","duration":"841.205331ms","start":"2026-05-26T14:28:30.966673Z","end":"2026-05-26T14:28:31.807878Z","steps":["trace[442884377] 'agreement among raft nodes before linearized reading' (duration: 841.092288ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:28:31.807889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.004881007s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-xpg8p\" ","response":"range_response_count:1 size:9789"} {"level":"warn","ts":"2026-05-26T14:28:31.807916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:28:30.966653Z","time spent":"841.255623ms","remote":"127.0.0.1:43444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22124,"request content":"key:\"/registry/pods/openstack/nova-compute-default-k2vrr\" "} {"level":"info","ts":"2026-05-26T14:28:31.807921Z","caller":"traceutil/trace.go:171","msg":"trace[858868023] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-xpg8p; range_end:; response_count:1; response_revision:19121; }","duration":"1.00497828s","start":"2026-05-26T14:28:30.802934Z","end":"2026-05-26T14:28:31.807912Z","steps":["trace[858868023] 'agreement among raft nodes before linearized reading' (duration: 1.004874917s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:28:31.807945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:28:30.802911Z","time spent":"1.005027102s","remote":"127.0.0.1:43444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":9812,"request content":"key:\"/registry/pods/openstack/nova-cell-setup-xpg8p\" "} {"level":"warn","ts":"2026-05-26T14:28:31.808036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.377677804s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8j77d\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-05-26T14:28:31.808061Z","caller":"traceutil/trace.go:171","msg":"trace[1384146116] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8j77d; range_end:; response_count:1; response_revision:19121; }","duration":"1.377728006s","start":"2026-05-26T14:28:30.430325Z","end":"2026-05-26T14:28:31.808053Z","steps":["trace[1384146116] 'agreement among raft nodes before linearized reading' (duration: 1.377680945s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T14:28:31.808085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T14:28:30.430312Z","time spent":"1.377764997s","remote":"127.0.0.1:43444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6554,"request content":"key:\"/registry/pods/openstack/keepalived-8j77d\" "} {"level":"info","ts":"2026-05-26T14:29:12.002198Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"1cac722af8b2b8a6","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-26T14:29:12.00736Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-05-26T14:29:12.007448Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}