{"level":"warn","ts":"2026-02-26T16:51:43.350103Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-26T16:51:43.350196Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.138: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.138:2380","--initial-cluster=instance=https://199.204.45.138:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.138:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.138: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-02-26T16:51:43.350259Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-26T16:51:43.350272Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-02-26T16:51:43.350291Z","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-02-26T16:51:43.350952Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"]} {"level":"info","ts":"2026-02-26T16:51:43.351029Z","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.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.138: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-02-26T16:51:43.354972Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.770015ms"} {"level":"info","ts":"2026-02-26T16:51:43.370899Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f3d52791b64f7591","cluster-id":"90076b89649fe294"} {"level":"info","ts":"2026-02-26T16:51:43.371046Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=()"} {"level":"info","ts":"2026-02-26T16:51:43.371077Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 0"} {"level":"info","ts":"2026-02-26T16:51:43.371092Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f3d52791b64f7591 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-26T16:51:43.371123Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became follower at term 1"} {"level":"info","ts":"2026-02-26T16:51:43.371176Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"warn","ts":"2026-02-26T16:51:43.379102Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-26T16:51:43.380616Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-26T16:51:43.381804Z","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-02-26T16:51:43.384025Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f3d52791b64f7591","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-26T16:51:43.384246Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f3d52791b64f7591","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-26T16:51:43.384421Z","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-02-26T16:51:43.384494Z","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-02-26T16:51:43.384506Z","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-02-26T16:51:43.387585Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 switched to configuration voters=(17569993028038260113)"} {"level":"info","ts":"2026-02-26T16:51:43.387982Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","added-peer-id":"f3d52791b64f7591","added-peer-peer-urls":["https://199.204.45.138:2380"]} {"level":"info","ts":"2026-02-26T16:51:43.389602Z","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-02-26T16:51:43.389837Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-02-26T16:51:43.389881Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.138:2380"} {"level":"info","ts":"2026-02-26T16:51:43.39017Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f3d52791b64f7591","initial-advertise-peer-urls":["https://199.204.45.138:2380"],"listen-peer-urls":["https://199.204.45.138:2380"],"advertise-client-urls":["https://199.204.45.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-26T16:51:43.39022Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-26T16:51:44.081165Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 is starting a new election at term 1"} {"level":"info","ts":"2026-02-26T16:51:44.081243Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-26T16:51:44.081288Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgPreVoteResp from f3d52791b64f7591 at term 1"} {"level":"info","ts":"2026-02-26T16:51:44.081307Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became candidate at term 2"} {"level":"info","ts":"2026-02-26T16:51:44.081316Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 received MsgVoteResp from f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-02-26T16:51:44.081328Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f3d52791b64f7591 became leader at term 2"} {"level":"info","ts":"2026-02-26T16:51:44.08134Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f3d52791b64f7591 elected leader f3d52791b64f7591 at term 2"} {"level":"info","ts":"2026-02-26T16:51:44.106164Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T16:51:44.117895Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-26T16:51:44.117897Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f3d52791b64f7591","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.138:2379]}","request-path":"/0/members/f3d52791b64f7591/attributes","cluster-id":"90076b89649fe294","publish-timeout":"7s"} {"level":"info","ts":"2026-02-26T16:51:44.11796Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-26T16:51:44.118311Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-26T16:51:44.118397Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-26T16:51:44.12083Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"90076b89649fe294","local-member-id":"f3d52791b64f7591","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T16:51:44.120977Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.138:2379"} {"level":"info","ts":"2026-02-26T16:51:44.12101Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-26T16:51:44.121277Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T16:51:44.121332Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T16:52:01.146251Z","caller":"traceutil/trace.go:171","msg":"trace[1558047724] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"266.223848ms","start":"2026-02-26T16:52:00.88Z","end":"2026-02-26T16:52:01.146224Z","steps":["trace[1558047724] 'process raft request' (duration: 266.055124ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:52:06.933773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.55087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T16:52:06.933934Z","caller":"traceutil/trace.go:171","msg":"trace[2062507412] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:460; }","duration":"416.778875ms","start":"2026-02-26T16:52:06.517134Z","end":"2026-02-26T16:52:06.933913Z","steps":["trace[2062507412] 'range keys from in-memory index tree' (duration: 416.388756ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:52:06.933976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:52:06.517095Z","time spent":"416.872476ms","remote":"127.0.0.1:59796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-26T16:52:18.472783Z","caller":"traceutil/trace.go:171","msg":"trace[762068832] linearizableReadLoop","detail":"{readStateIndex:564; appliedIndex:563; }","duration":"117.149258ms","start":"2026-02-26T16:52:18.35561Z","end":"2026-02-26T16:52:18.472759Z","steps":["trace[762068832] 'read index received' (duration: 78.570075ms)","trace[762068832] 'applied index is now lower than readState.Index' (duration: 38.578093ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:52:18.472919Z","caller":"traceutil/trace.go:171","msg":"trace[1404291106] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"118.153288ms","start":"2026-02-26T16:52:18.354734Z","end":"2026-02-26T16:52:18.472887Z","steps":["trace[1404291106] 'process raft request' (duration: 79.422592ms)","trace[1404291106] 'compare' (duration: 38.494701ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T16:52:18.472992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.359312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:1 size:12755"} {"level":"info","ts":"2026-02-26T16:52:18.473143Z","caller":"traceutil/trace.go:171","msg":"trace[2118780784] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:545; }","duration":"117.550226ms","start":"2026-02-26T16:52:18.355567Z","end":"2026-02-26T16:52:18.473118Z","steps":["trace[2118780784] 'agreement among raft nodes before linearized reading' (duration: 117.278511ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:52:21.601999Z","caller":"traceutil/trace.go:171","msg":"trace[808060448] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"254.509292ms","start":"2026-02-26T16:52:21.347463Z","end":"2026-02-26T16:52:21.601972Z","steps":["trace[808060448] 'process raft request' (duration: 254.342869ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:52:22.451107Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471724563007967154,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-26T16:52:22.806901Z","caller":"traceutil/trace.go:171","msg":"trace[1021462765] linearizableReadLoop","detail":"{readStateIndex:574; appliedIndex:573; }","duration":"886.907856ms","start":"2026-02-26T16:52:21.91997Z","end":"2026-02-26T16:52:22.806878Z","steps":["trace[1021462765] 'read index received' (duration: 886.687042ms)","trace[1021462765] 'applied index is now lower than readState.Index' (duration: 219.904µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:52:22.806988Z","caller":"traceutil/trace.go:171","msg":"trace[1590126175] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"907.614963ms","start":"2026-02-26T16:52:21.899331Z","end":"2026-02-26T16:52:22.806946Z","steps":["trace[1590126175] 'process raft request' (duration: 907.409939ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:52:22.807115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"887.131341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/cert-manager/\" range_end:\"/registry/secrets/cert-manager0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T16:52:22.807213Z","caller":"traceutil/trace.go:171","msg":"trace[528795143] range","detail":"{range_begin:/registry/secrets/cert-manager/; range_end:/registry/secrets/cert-manager0; response_count:0; response_revision:555; }","duration":"887.275904ms","start":"2026-02-26T16:52:21.919915Z","end":"2026-02-26T16:52:22.80719Z","steps":["trace[528795143] 'agreement among raft nodes before linearized reading' (duration: 887.120591ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:52:22.807262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:52:21.919896Z","time spent":"887.357446ms","remote":"127.0.0.1:59870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":29,"request content":"key:\"/registry/secrets/cert-manager/\" range_end:\"/registry/secrets/cert-manager0\" "} {"level":"warn","ts":"2026-02-26T16:52:22.80722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.283268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T16:52:22.807355Z","caller":"traceutil/trace.go:171","msg":"trace[622742719] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:555; }","duration":"291.438023ms","start":"2026-02-26T16:52:22.515867Z","end":"2026-02-26T16:52:22.807305Z","steps":["trace[622742719] 'agreement among raft nodes before linearized reading' (duration: 291.288019ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:52:22.807378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"754.627116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-26T16:52:22.807546Z","caller":"traceutil/trace.go:171","msg":"trace[1172291689] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:555; }","duration":"754.82845ms","start":"2026-02-26T16:52:22.052705Z","end":"2026-02-26T16:52:22.807533Z","steps":["trace[1172291689] 'agreement among raft nodes before linearized reading' (duration: 754.524413ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:52:22.807587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:52:22.052683Z","time spent":"754.892491ms","remote":"127.0.0.1:60052","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-02-26T16:52:22.807393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.279828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-26T16:52:22.807677Z","caller":"traceutil/trace.go:171","msg":"trace[207933365] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:555; }","duration":"505.596105ms","start":"2026-02-26T16:52:22.302061Z","end":"2026-02-26T16:52:22.807657Z","steps":["trace[207933365] 'agreement among raft nodes before linearized reading' (duration: 505.153365ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:52:22.807388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"883.095292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-26T16:52:22.807732Z","caller":"traceutil/trace.go:171","msg":"trace[1694198878] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:555; }","duration":"883.470849ms","start":"2026-02-26T16:52:21.924251Z","end":"2026-02-26T16:52:22.807721Z","steps":["trace[1694198878] 'agreement among raft nodes before linearized reading' (duration: 882.877206ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:52:22.807736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:52:22.302043Z","time spent":"505.675346ms","remote":"127.0.0.1:60052","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-02-26T16:52:22.807764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:52:21.924244Z","time spent":"883.51012ms","remote":"127.0.0.1:60052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-26T16:52:22.807807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:52:21.899304Z","time spent":"907.802546ms","remote":"127.0.0.1:60052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T16:52:24.620147Z","caller":"traceutil/trace.go:171","msg":"trace[1343449031] linearizableReadLoop","detail":"{readStateIndex:721; appliedIndex:720; }","duration":"103.78464ms","start":"2026-02-26T16:52:24.516331Z","end":"2026-02-26T16:52:24.620115Z","steps":["trace[1343449031] 'read index received' (duration: 96.196577ms)","trace[1343449031] 'applied index is now lower than readState.Index' (duration: 7.586983ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:52:24.62022Z","caller":"traceutil/trace.go:171","msg":"trace[544075902] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"156.034568ms","start":"2026-02-26T16:52:24.464146Z","end":"2026-02-26T16:52:24.62018Z","steps":["trace[544075902] 'process raft request' (duration: 148.463586ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:52:24.620328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.970364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T16:52:24.620375Z","caller":"traceutil/trace.go:171","msg":"trace[715645128] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:700; }","duration":"104.081906ms","start":"2026-02-26T16:52:24.516279Z","end":"2026-02-26T16:52:24.620361Z","steps":["trace[715645128] 'agreement among raft nodes before linearized reading' (duration: 103.957373ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:52:27.911325Z","caller":"traceutil/trace.go:171","msg":"trace[1088185027] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"157.18732ms","start":"2026-02-26T16:52:27.75411Z","end":"2026-02-26T16:52:27.911297Z","steps":["trace[1088185027] 'process raft request' (duration: 156.980176ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:52:50.515594Z","caller":"traceutil/trace.go:171","msg":"trace[1288065955] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"100.51113ms","start":"2026-02-26T16:52:50.415058Z","end":"2026-02-26T16:52:50.515569Z","steps":["trace[1288065955] 'process raft request' (duration: 100.386708ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:53:05.219426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.504415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-26T16:53:05.219518Z","caller":"traceutil/trace.go:171","msg":"trace[1046443896] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1180; }","duration":"166.657977ms","start":"2026-02-26T16:53:05.052842Z","end":"2026-02-26T16:53:05.2195Z","steps":["trace[1046443896] 'count revisions from in-memory index tree' (duration: 166.417653ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:53:05.219615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.543339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-26T16:53:05.219679Z","caller":"traceutil/trace.go:171","msg":"trace[1668534977] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1180; }","duration":"131.62418ms","start":"2026-02-26T16:53:05.088042Z","end":"2026-02-26T16:53:05.219666Z","steps":["trace[1668534977] 'range keys from in-memory index tree' (duration: 131.272043ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:53:05.219659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.592489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-26T16:53:05.219722Z","caller":"traceutil/trace.go:171","msg":"trace[2055419539] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1180; }","duration":"135.696001ms","start":"2026-02-26T16:53:05.084009Z","end":"2026-02-26T16:53:05.219705Z","steps":["trace[2055419539] 'range keys from in-memory index tree' (duration: 135.324804ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:53:07.881831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.066795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-26T16:53:07.88192Z","caller":"traceutil/trace.go:171","msg":"trace[586023583] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1196; }","duration":"194.207087ms","start":"2026-02-26T16:53:07.687691Z","end":"2026-02-26T16:53:07.881898Z","steps":["trace[586023583] 'count revisions from in-memory index tree' (duration: 193.986803ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:53:29.181204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.142252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-02-26T16:53:29.181328Z","caller":"traceutil/trace.go:171","msg":"trace[1318048155] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1575; }","duration":"238.300765ms","start":"2026-02-26T16:53:28.942993Z","end":"2026-02-26T16:53:29.181294Z","steps":["trace[1318048155] 'range keys from in-memory index tree' (duration: 237.935368ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:53:29.780626Z","caller":"traceutil/trace.go:171","msg":"trace[494965202] transaction","detail":"{read_only:false; response_revision:1576; number_of_response:1; }","duration":"595.832904ms","start":"2026-02-26T16:53:29.184767Z","end":"2026-02-26T16:53:29.7806Z","steps":["trace[494965202] 'process raft request' (duration: 595.662451ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:53:29.780881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.509228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-71db685a-bdee-4e8b-99c6-dbdb8fe70f06\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-02-26T16:53:29.780638Z","caller":"traceutil/trace.go:171","msg":"trace[1020672547] linearizableReadLoop","detail":"{readStateIndex:1638; appliedIndex:1637; }","duration":"475.237383ms","start":"2026-02-26T16:53:29.305353Z","end":"2026-02-26T16:53:29.78059Z","steps":["trace[1020672547] 'read index received' (duration: 475.221233ms)","trace[1020672547] 'applied index is now lower than readState.Index' (duration: 13.6µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:53:29.780939Z","caller":"traceutil/trace.go:171","msg":"trace[536816667] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-71db685a-bdee-4e8b-99c6-dbdb8fe70f06; range_end:; response_count:1; response_revision:1576; }","duration":"475.625781ms","start":"2026-02-26T16:53:29.3053Z","end":"2026-02-26T16:53:29.780926Z","steps":["trace[536816667] 'agreement among raft nodes before linearized reading' (duration: 475.403126ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:53:29.780991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:53:29.305277Z","time spent":"475.704352ms","remote":"127.0.0.1:59974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3651,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-71db685a-bdee-4e8b-99c6-dbdb8fe70f06\" "} {"level":"warn","ts":"2026-02-26T16:53:29.780893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:53:29.18475Z","time spent":"596.052368ms","remote":"127.0.0.1:60052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T16:53:29.830394Z","caller":"traceutil/trace.go:171","msg":"trace[1335184157] transaction","detail":"{read_only:false; response_revision:1577; number_of_response:1; }","duration":"137.399016ms","start":"2026-02-26T16:53:29.692973Z","end":"2026-02-26T16:53:29.830372Z","steps":["trace[1335184157] 'process raft request' (duration: 106.792136ms)","trace[1335184157] 'compare' (duration: 30.407906ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T16:53:29.830435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.641149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-02-26T16:53:29.830444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.90103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-26T16:53:29.830507Z","caller":"traceutil/trace.go:171","msg":"trace[1177384995] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1577; }","duration":"375.749512ms","start":"2026-02-26T16:53:29.45474Z","end":"2026-02-26T16:53:29.830489Z","steps":["trace[1177384995] 'agreement among raft nodes before linearized reading' (duration: 375.553228ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:53:29.830523Z","caller":"traceutil/trace.go:171","msg":"trace[1818826208] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1577; }","duration":"207.046932ms","start":"2026-02-26T16:53:29.623457Z","end":"2026-02-26T16:53:29.830504Z","steps":["trace[1818826208] 'agreement among raft nodes before linearized reading' (duration: 206.892889ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:53:29.830558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:53:29.454718Z","time spent":"375.831093ms","remote":"127.0.0.1:60052","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-02-26T16:53:29.830484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.564032ms","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-02-26T16:53:29.830607Z","caller":"traceutil/trace.go:171","msg":"trace[1921606142] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1577; }","duration":"346.740625ms","start":"2026-02-26T16:53:29.483854Z","end":"2026-02-26T16:53:29.830595Z","steps":["trace[1921606142] 'agreement among raft nodes before linearized reading' (duration: 346.549511ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:53:29.830696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:53:29.483823Z","time spent":"346.847757ms","remote":"127.0.0.1:60052","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-02-26T16:53:29.830711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.764335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-26T16:53:29.830799Z","caller":"traceutil/trace.go:171","msg":"trace[1291265230] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1577; }","duration":"347.926758ms","start":"2026-02-26T16:53:29.482851Z","end":"2026-02-26T16:53:29.830778Z","steps":["trace[1291265230] 'agreement among raft nodes before linearized reading' (duration: 347.673203ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:53:29.830863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:53:29.482831Z","time spent":"348.0222ms","remote":"127.0.0.1:60052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-26T16:53:29.830719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.140993ms","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-02-26T16:53:29.830937Z","caller":"traceutil/trace.go:171","msg":"trace[599629143] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1577; }","duration":"341.406658ms","start":"2026-02-26T16:53:29.489512Z","end":"2026-02-26T16:53:29.830918Z","steps":["trace[599629143] 'agreement among raft nodes before linearized reading' (duration: 340.97653ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:53:29.830998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:53:29.489503Z","time spent":"341.48054ms","remote":"127.0.0.1:60052","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-02-26T16:53:29.831211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.410846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-71db685a-bdee-4e8b-99c6-dbdb8fe70f06\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-02-26T16:53:29.831344Z","caller":"traceutil/trace.go:171","msg":"trace[69302051] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-71db685a-bdee-4e8b-99c6-dbdb8fe70f06; range_end:; response_count:1; response_revision:1577; }","duration":"140.582869ms","start":"2026-02-26T16:53:29.690741Z","end":"2026-02-26T16:53:29.831324Z","steps":["trace[69302051] 'agreement among raft nodes before linearized reading' (duration: 140.015028ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:53:29.990781Z","caller":"traceutil/trace.go:171","msg":"trace[713436463] transaction","detail":"{read_only:false; response_revision:1579; number_of_response:1; }","duration":"155.878963ms","start":"2026-02-26T16:53:29.834866Z","end":"2026-02-26T16:53:29.990745Z","steps":["trace[713436463] 'process raft request' (duration: 107.125433ms)","trace[713436463] 'compare' (duration: 48.542146ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:53:29.990865Z","caller":"traceutil/trace.go:171","msg":"trace[428792430] transaction","detail":"{read_only:false; response_revision:1580; number_of_response:1; }","duration":"155.884714ms","start":"2026-02-26T16:53:29.834951Z","end":"2026-02-26T16:53:29.990835Z","steps":["trace[428792430] 'process raft request' (duration: 155.68937ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:53:29.990906Z","caller":"traceutil/trace.go:171","msg":"trace[980275135] transaction","detail":"{read_only:false; response_revision:1582; number_of_response:1; }","duration":"153.548567ms","start":"2026-02-26T16:53:29.837329Z","end":"2026-02-26T16:53:29.990878Z","steps":["trace[980275135] 'process raft request' (duration: 153.441345ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:53:29.990824Z","caller":"traceutil/trace.go:171","msg":"trace[1741769821] transaction","detail":"{read_only:false; response_revision:1581; number_of_response:1; }","duration":"155.831093ms","start":"2026-02-26T16:53:29.834974Z","end":"2026-02-26T16:53:29.990805Z","steps":["trace[1741769821] 'process raft request' (duration: 155.762501ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:53:30.362783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.060266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-02-26T16:53:30.362877Z","caller":"traceutil/trace.go:171","msg":"trace[1077346814] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1582; }","duration":"175.215509ms","start":"2026-02-26T16:53:30.187639Z","end":"2026-02-26T16:53:30.362854Z","steps":["trace[1077346814] 'range keys from in-memory index tree' (duration: 174.818222ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:55:04.473192Z","caller":"traceutil/trace.go:171","msg":"trace[937985718] transaction","detail":"{read_only:false; response_revision:2233; number_of_response:1; }","duration":"115.353622ms","start":"2026-02-26T16:55:04.357814Z","end":"2026-02-26T16:55:04.473168Z","steps":["trace[937985718] 'process raft request' (duration: 115.234429ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:55:07.668338Z","caller":"traceutil/trace.go:171","msg":"trace[1145881895] linearizableReadLoop","detail":"{readStateIndex:2378; appliedIndex:2377; }","duration":"102.249195ms","start":"2026-02-26T16:55:07.566069Z","end":"2026-02-26T16:55:07.668319Z","steps":["trace[1145881895] 'read index received' (duration: 102.175653ms)","trace[1145881895] 'applied index is now lower than readState.Index' (duration: 72.812µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:55:07.668419Z","caller":"traceutil/trace.go:171","msg":"trace[1333336435] transaction","detail":"{read_only:false; response_revision:2287; number_of_response:1; }","duration":"337.295325ms","start":"2026-02-26T16:55:07.331089Z","end":"2026-02-26T16:55:07.668384Z","steps":["trace[1333336435] 'process raft request' (duration: 337.078161ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:55:07.668577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.493979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.138\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-02-26T16:55:07.668599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:55:07.331064Z","time spent":"337.449948ms","remote":"127.0.0.1:60052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T16:55:07.668619Z","caller":"traceutil/trace.go:171","msg":"trace[358947117] range","detail":"{range_begin:/registry/masterleases/199.204.45.138; range_end:; response_count:1; response_revision:2287; }","duration":"102.613092ms","start":"2026-02-26T16:55:07.565995Z","end":"2026-02-26T16:55:07.668608Z","steps":["trace[358947117] 'agreement among raft nodes before linearized reading' (duration: 102.468759ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:55:42.565772Z","caller":"traceutil/trace.go:171","msg":"trace[1364368384] transaction","detail":"{read_only:false; response_revision:2479; number_of_response:1; }","duration":"177.084806ms","start":"2026-02-26T16:55:42.388661Z","end":"2026-02-26T16:55:42.565745Z","steps":["trace[1364368384] 'process raft request' (duration: 176.655078ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:55:42.947231Z","caller":"traceutil/trace.go:171","msg":"trace[2012823649] transaction","detail":"{read_only:false; response_revision:2480; number_of_response:1; }","duration":"377.072951ms","start":"2026-02-26T16:55:42.570117Z","end":"2026-02-26T16:55:42.94719Z","steps":["trace[2012823649] 'process raft request' (duration: 376.814886ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:55:42.947493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:55:42.570106Z","time spent":"377.232934ms","remote":"127.0.0.1:59852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":750,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T16:55:43.00915Z","caller":"traceutil/trace.go:171","msg":"trace[664613189] transaction","detail":"{read_only:false; response_revision:2481; number_of_response:1; }","duration":"438.222945ms","start":"2026-02-26T16:55:42.5709Z","end":"2026-02-26T16:55:43.009123Z","steps":["trace[664613189] 'process raft request' (duration: 432.829599ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:55:43.009147Z","caller":"traceutil/trace.go:171","msg":"trace[900059236] transaction","detail":"{read_only:false; response_revision:2482; number_of_response:1; }","duration":"437.788756ms","start":"2026-02-26T16:55:42.57133Z","end":"2026-02-26T16:55:43.009119Z","steps":["trace[900059236] 'process raft request' (duration: 437.703334ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:55:43.009283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:55:42.570875Z","time spent":"438.337497ms","remote":"127.0.0.1:60052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T16:55:43.009482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:55:42.571302Z","time spent":"438.056102ms","remote":"127.0.0.1:60052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T16:55:43.011785Z","caller":"traceutil/trace.go:171","msg":"trace[1673639378] linearizableReadLoop","detail":"{readStateIndex:2580; appliedIndex:2577; }","duration":"397.663717ms","start":"2026-02-26T16:55:42.614089Z","end":"2026-02-26T16:55:43.011753Z","steps":["trace[1673639378] 'read index received' (duration: 332.871472ms)","trace[1673639378] 'applied index is now lower than readState.Index' (duration: 64.788865ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T16:55:43.012162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.516633ms","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-02-26T16:55:43.012164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.055204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-02-26T16:55:43.012216Z","caller":"traceutil/trace.go:171","msg":"trace[1535452881] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2482; }","duration":"305.635996ms","start":"2026-02-26T16:55:42.706567Z","end":"2026-02-26T16:55:43.012203Z","steps":["trace[1535452881] 'agreement among raft nodes before linearized reading' (duration: 305.35993ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:55:43.012211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.483446ms","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-02-26T16:55:43.012262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:55:42.706541Z","time spent":"305.709807ms","remote":"127.0.0.1:60052","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-02-26T16:55:43.012287Z","caller":"traceutil/trace.go:171","msg":"trace[1855015824] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2482; }","duration":"398.184027ms","start":"2026-02-26T16:55:42.614036Z","end":"2026-02-26T16:55:43.01222Z","steps":["trace[1855015824] 'agreement among raft nodes before linearized reading' (duration: 397.84174ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:55:43.012398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:55:42.614022Z","time spent":"398.35941ms","remote":"127.0.0.1:59978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1393,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"warn","ts":"2026-02-26T16:55:43.01215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.354776ms","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-02-26T16:55:43.012283Z","caller":"traceutil/trace.go:171","msg":"trace[1378600288] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2482; }","duration":"290.564488ms","start":"2026-02-26T16:55:42.721704Z","end":"2026-02-26T16:55:43.012268Z","steps":["trace[1378600288] 'agreement among raft nodes before linearized reading' (duration: 290.311873ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:55:43.012548Z","caller":"traceutil/trace.go:171","msg":"trace[949476721] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2482; }","duration":"288.796435ms","start":"2026-02-26T16:55:42.723728Z","end":"2026-02-26T16:55:43.012524Z","steps":["trace[949476721] 'agreement among raft nodes before linearized reading' (duration: 288.277444ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:58:03.129934Z","caller":"traceutil/trace.go:171","msg":"trace[1484219961] transaction","detail":"{read_only:false; response_revision:3352; number_of_response:1; }","duration":"135.675023ms","start":"2026-02-26T16:58:02.994233Z","end":"2026-02-26T16:58:03.129908Z","steps":["trace[1484219961] 'process raft request' (duration: 135.495779ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:58:08.65614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.897288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T16:58:08.656303Z","caller":"traceutil/trace.go:171","msg":"trace[214752408] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3380; }","duration":"141.127932ms","start":"2026-02-26T16:58:08.515144Z","end":"2026-02-26T16:58:08.656272Z","steps":["trace[214752408] 'range keys from in-memory index tree' (duration: 140.744214ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:59:27.593198Z","caller":"traceutil/trace.go:171","msg":"trace[1792551956] transaction","detail":"{read_only:false; response_revision:4390; number_of_response:1; }","duration":"131.322508ms","start":"2026-02-26T16:59:27.461852Z","end":"2026-02-26T16:59:27.593175Z","steps":["trace[1792551956] 'process raft request' (duration: 131.183806ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:59:27.627784Z","caller":"traceutil/trace.go:171","msg":"trace[910606319] transaction","detail":"{read_only:false; response_revision:4391; number_of_response:1; }","duration":"156.664423ms","start":"2026-02-26T16:59:27.471095Z","end":"2026-02-26T16:59:27.62776Z","steps":["trace[910606319] 'process raft request' (duration: 156.441589ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:59:27.628191Z","caller":"traceutil/trace.go:171","msg":"trace[1273221375] transaction","detail":"{read_only:false; response_revision:4392; number_of_response:1; }","duration":"123.917749ms","start":"2026-02-26T16:59:27.50426Z","end":"2026-02-26T16:59:27.628177Z","steps":["trace[1273221375] 'process raft request' (duration: 123.43874ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:59:29.644826Z","caller":"traceutil/trace.go:171","msg":"trace[1661732674] transaction","detail":"{read_only:false; response_revision:4502; number_of_response:1; }","duration":"159.918918ms","start":"2026-02-26T16:59:29.484879Z","end":"2026-02-26T16:59:29.644798Z","steps":["trace[1661732674] 'process raft request' (duration: 159.574051ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:59:29.733862Z","caller":"traceutil/trace.go:171","msg":"trace[1222525758] linearizableReadLoop","detail":"{readStateIndex:4682; appliedIndex:4680; }","duration":"217.131259ms","start":"2026-02-26T16:59:29.516688Z","end":"2026-02-26T16:59:29.733819Z","steps":["trace[1222525758] 'read index received' (duration: 127.752127ms)","trace[1222525758] 'applied index is now lower than readState.Index' (duration: 89.377292ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T16:59:29.734269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.607283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T16:59:29.734331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.621679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T16:59:29.734391Z","caller":"traceutil/trace.go:171","msg":"trace[1456318878] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:4504; }","duration":"142.796437ms","start":"2026-02-26T16:59:29.591558Z","end":"2026-02-26T16:59:29.734355Z","steps":["trace[1456318878] 'agreement among raft nodes before linearized reading' (duration: 142.582622ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:59:29.73436Z","caller":"traceutil/trace.go:171","msg":"trace[941261562] transaction","detail":"{read_only:false; response_revision:4503; number_of_response:1; }","duration":"247.649917ms","start":"2026-02-26T16:59:29.486019Z","end":"2026-02-26T16:59:29.733669Z","steps":["trace[941261562] 'process raft request' (duration: 246.425082ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:59:29.734453Z","caller":"traceutil/trace.go:171","msg":"trace[1953894065] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4504; }","duration":"217.790842ms","start":"2026-02-26T16:59:29.516635Z","end":"2026-02-26T16:59:29.734425Z","steps":["trace[1953894065] 'agreement among raft nodes before linearized reading' (duration: 217.598268ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:59:41.995471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"739.296278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-26T16:59:41.995635Z","caller":"traceutil/trace.go:171","msg":"trace[804194682] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4731; }","duration":"739.497661ms","start":"2026-02-26T16:59:41.256095Z","end":"2026-02-26T16:59:41.995592Z","steps":["trace[804194682] 'count revisions from in-memory index tree' (duration: 739.204836ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:59:41.995658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.254814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T16:59:41.995699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:59:41.256081Z","time spent":"739.597544ms","remote":"127.0.0.1:35922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"info","ts":"2026-02-26T16:59:41.99575Z","caller":"traceutil/trace.go:171","msg":"trace[1112615652] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4731; }","duration":"477.61512ms","start":"2026-02-26T16:59:41.51811Z","end":"2026-02-26T16:59:41.995725Z","steps":["trace[1112615652] 'range keys from in-memory index tree' (duration: 477.178821ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:59:41.995799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:59:41.51809Z","time spent":"477.698742ms","remote":"127.0.0.1:59796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-26T16:59:41.995811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.896597ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T16:59:41.995983Z","caller":"traceutil/trace.go:171","msg":"trace[1750411638] linearizableReadLoop","detail":"{readStateIndex:4919; appliedIndex:4917; }","duration":"165.250694ms","start":"2026-02-26T16:59:41.830719Z","end":"2026-02-26T16:59:41.995969Z","steps":["trace[1750411638] 'read index received' (duration: 137.630593ms)","trace[1750411638] 'applied index is now lower than readState.Index' (duration: 27.619131ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T16:59:41.996081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.301999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-795n2\" ","response":"range_response_count:1 size:7818"} {"level":"info","ts":"2026-02-26T16:59:41.996103Z","caller":"traceutil/trace.go:171","msg":"trace[145125371] transaction","detail":"{read_only:false; response_revision:4733; number_of_response:1; }","duration":"182.243033ms","start":"2026-02-26T16:59:41.813828Z","end":"2026-02-26T16:59:41.996071Z","steps":["trace[145125371] 'process raft request' (duration: 182.056009ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:59:41.996153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.435147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-6bppt\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-02-26T16:59:41.996227Z","caller":"traceutil/trace.go:171","msg":"trace[1253327790] range","detail":"{range_begin:/registry/pods/openstack/keepalived-6bppt; range_end:; response_count:1; response_revision:4733; }","duration":"165.573491ms","start":"2026-02-26T16:59:41.830643Z","end":"2026-02-26T16:59:41.996217Z","steps":["trace[1253327790] 'agreement among raft nodes before linearized reading' (duration: 165.376397ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:59:41.996125Z","caller":"traceutil/trace.go:171","msg":"trace[812627336] transaction","detail":"{read_only:false; response_revision:4732; number_of_response:1; }","duration":"364.140249ms","start":"2026-02-26T16:59:41.631938Z","end":"2026-02-26T16:59:41.996079Z","steps":["trace[812627336] 'process raft request' (duration: 44.706081ms)","trace[812627336] 'compare' (duration: 318.464609ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:59:41.996321Z","caller":"traceutil/trace.go:171","msg":"trace[604544112] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-795n2; range_end:; response_count:1; response_revision:4731; }","duration":"396.600745ms","start":"2026-02-26T16:59:41.599694Z","end":"2026-02-26T16:59:41.996295Z","steps":["trace[604544112] 'range keys from in-memory index tree' (duration: 395.608946ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:59:41.996352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:59:41.631914Z","time spent":"364.353074ms","remote":"127.0.0.1:60052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T16:59:41.996429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:59:41.599627Z","time spent":"396.756669ms","remote":"127.0.0.1:59974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":7842,"request content":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-795n2\" "} {"level":"info","ts":"2026-02-26T16:59:44.830991Z","caller":"traceutil/trace.go:171","msg":"trace[633944275] transaction","detail":"{read_only:false; response_revision:4777; number_of_response:1; }","duration":"118.359219ms","start":"2026-02-26T16:59:44.712607Z","end":"2026-02-26T16:59:44.830966Z","steps":["trace[633944275] 'process raft request' (duration: 19.578711ms)","trace[633944275] 'compare' (duration: 98.644526ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T16:59:49.633713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.32248ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-26T16:59:49.633954Z","caller":"traceutil/trace.go:171","msg":"trace[335927131] transaction","detail":"{read_only:false; response_revision:4881; number_of_response:1; }","duration":"133.188336ms","start":"2026-02-26T16:59:49.500741Z","end":"2026-02-26T16:59:49.633929Z","steps":["trace[335927131] 'process raft request' (duration: 133.095124ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:59:49.633961Z","caller":"traceutil/trace.go:171","msg":"trace[739935380] linearizableReadLoop","detail":"{readStateIndex:5069; appliedIndex:5068; }","duration":"459.170944ms","start":"2026-02-26T16:59:49.174759Z","end":"2026-02-26T16:59:49.63393Z","steps":["trace[739935380] 'read index received' (duration: 199.494857ms)","trace[739935380] 'applied index is now lower than readState.Index' (duration: 259.673057ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:59:49.634007Z","caller":"traceutil/trace.go:171","msg":"trace[1249576367] transaction","detail":"{read_only:false; response_revision:4880; number_of_response:1; }","duration":"461.042021ms","start":"2026-02-26T16:59:49.172921Z","end":"2026-02-26T16:59:49.633963Z","steps":["trace[1249576367] 'process raft request' (duration: 201.393655ms)","trace[1249576367] 'compare' (duration: 259.167656ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T16:59:49.634209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:59:49.172904Z","time spent":"461.200794ms","remote":"127.0.0.1:44242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3661,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T16:59:49.634248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.470269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-02-26T16:59:49.634285Z","caller":"traceutil/trace.go:171","msg":"trace[970672942] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4881; }","duration":"459.561591ms","start":"2026-02-26T16:59:49.174712Z","end":"2026-02-26T16:59:49.634274Z","steps":["trace[970672942] 'agreement among raft nodes before linearized reading' (duration: 459.375848ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:59:49.634331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:59:49.174666Z","time spent":"459.654973ms","remote":"127.0.0.1:59978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":1309,"request content":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" "} {"level":"warn","ts":"2026-02-26T16:59:49.634333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.069593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T16:59:49.634374Z","caller":"traceutil/trace.go:171","msg":"trace[760651340] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4881; }","duration":"118.158805ms","start":"2026-02-26T16:59:49.516204Z","end":"2026-02-26T16:59:49.634363Z","steps":["trace[760651340] 'agreement among raft nodes before linearized reading' (duration: 118.074573ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:59:49.63451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.708308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d09b5033-8002-4a6b-b5d5-0a7310125b8e\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-02-26T16:59:49.634591Z","caller":"traceutil/trace.go:171","msg":"trace[835540905] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d09b5033-8002-4a6b-b5d5-0a7310125b8e; range_end:; response_count:1; response_revision:4881; }","duration":"242.79991ms","start":"2026-02-26T16:59:49.391772Z","end":"2026-02-26T16:59:49.634572Z","steps":["trace[835540905] 'agreement among raft nodes before linearized reading' (duration: 242.589876ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:59:49.642318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.231447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2209360"} {"level":"info","ts":"2026-02-26T16:59:49.642482Z","caller":"traceutil/trace.go:171","msg":"trace[652954368] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:4881; }","duration":"281.39643ms","start":"2026-02-26T16:59:49.361052Z","end":"2026-02-26T16:59:49.642449Z","steps":["trace[652954368] 'agreement among raft nodes before linearized reading' (duration: 273.078954ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:59:50.286177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.186074ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-26T16:59:50.286561Z","caller":"traceutil/trace.go:171","msg":"trace[1152459346] transaction","detail":"{read_only:false; response_revision:4883; number_of_response:1; }","duration":"644.909157ms","start":"2026-02-26T16:59:49.641606Z","end":"2026-02-26T16:59:50.286515Z","steps":["trace[1152459346] 'process raft request' (duration: 345.238973ms)","trace[1152459346] 'compare' (duration: 298.912948ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:59:50.286595Z","caller":"traceutil/trace.go:171","msg":"trace[888636016] transaction","detail":"{read_only:false; response_revision:4884; number_of_response:1; }","duration":"644.475707ms","start":"2026-02-26T16:59:49.642081Z","end":"2026-02-26T16:59:50.286557Z","steps":["trace[888636016] 'process raft request' (duration: 644.329845ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:59:50.286653Z","caller":"traceutil/trace.go:171","msg":"trace[985812118] transaction","detail":"{read_only:false; response_revision:4885; number_of_response:1; }","duration":"643.58139ms","start":"2026-02-26T16:59:49.643038Z","end":"2026-02-26T16:59:50.286619Z","steps":["trace[985812118] 'process raft request' (duration: 643.461987ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:59:50.286772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:59:49.641584Z","time spent":"645.07417ms","remote":"127.0.0.1:59852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":934,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T16:59:50.286782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:59:49.642073Z","time spent":"644.59969ms","remote":"127.0.0.1:59852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":919,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T16:59:50.286834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:59:49.643029Z","time spent":"643.727343ms","remote":"127.0.0.1:59852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":922,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T16:59:50.286825Z","caller":"traceutil/trace.go:171","msg":"trace[1866143029] transaction","detail":"{read_only:false; response_revision:4886; number_of_response:1; }","duration":"642.901736ms","start":"2026-02-26T16:59:49.643803Z","end":"2026-02-26T16:59:50.286705Z","steps":["trace[1866143029] 'process raft request' (duration: 642.756014ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:59:50.286903Z","caller":"traceutil/trace.go:171","msg":"trace[872543920] transaction","detail":"{read_only:false; response_revision:4888; number_of_response:1; }","duration":"636.027189ms","start":"2026-02-26T16:59:49.650859Z","end":"2026-02-26T16:59:50.286886Z","steps":["trace[872543920] 'process raft request' (duration: 635.792244ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:59:50.286957Z","caller":"traceutil/trace.go:171","msg":"trace[830227815] linearizableReadLoop","detail":"{readStateIndex:5072; appliedIndex:5070; }","duration":"644.971288ms","start":"2026-02-26T16:59:49.64193Z","end":"2026-02-26T16:59:50.286901Z","steps":["trace[830227815] 'read index received' (duration: 14.50656ms)","trace[830227815] 'applied index is now lower than readState.Index' (duration: 630.453578ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:59:50.286902Z","caller":"traceutil/trace.go:171","msg":"trace[1484281321] transaction","detail":"{read_only:false; response_revision:4887; number_of_response:1; }","duration":"637.55592ms","start":"2026-02-26T16:59:49.649283Z","end":"2026-02-26T16:59:50.286839Z","steps":["trace[1484281321] 'process raft request' (duration: 637.310305ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:59:50.287029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:59:49.64378Z","time spent":"643.160012ms","remote":"127.0.0.1:59852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":916,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T16:59:50.287056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:59:49.650851Z","time spent":"636.126241ms","remote":"127.0.0.1:44242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4226,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T16:59:50.287077Z","caller":"traceutil/trace.go:171","msg":"trace[2110562634] transaction","detail":"{read_only:false; response_revision:4889; number_of_response:1; }","duration":"402.486983ms","start":"2026-02-26T16:59:49.884574Z","end":"2026-02-26T16:59:50.287061Z","steps":["trace[2110562634] 'process raft request' (duration: 402.225708ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:59:50.287091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:59:49.649267Z","time spent":"637.796324ms","remote":"127.0.0.1:59852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":910,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T16:59:50.287152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:59:49.884547Z","time spent":"402.561095ms","remote":"127.0.0.1:60052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T16:59:50.287254Z","caller":"traceutil/trace.go:171","msg":"trace[1575858653] transaction","detail":"{read_only:false; response_revision:4890; number_of_response:1; }","duration":"266.201297ms","start":"2026-02-26T16:59:50.021037Z","end":"2026-02-26T16:59:50.287239Z","steps":["trace[1575858653] 'process raft request' (duration: 265.956742ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:59:50.287334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"645.397006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-02-26T16:59:50.287375Z","caller":"traceutil/trace.go:171","msg":"trace[1401988768] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4889; }","duration":"645.467848ms","start":"2026-02-26T16:59:49.641897Z","end":"2026-02-26T16:59:50.287364Z","steps":["trace[1401988768] 'agreement among raft nodes before linearized reading' (duration: 645.205813ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:59:50.287407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:59:49.641879Z","time spent":"645.520409ms","remote":"127.0.0.1:59978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":1309,"request content":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" "} {"level":"warn","ts":"2026-02-26T16:59:50.287411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.372848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"warn","ts":"2026-02-26T16:59:50.287446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.738038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-6bppt\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-02-26T16:59:50.287497Z","caller":"traceutil/trace.go:171","msg":"trace[1882904263] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4890; }","duration":"615.49914ms","start":"2026-02-26T16:59:49.671977Z","end":"2026-02-26T16:59:50.287476Z","steps":["trace[1882904263] 'agreement among raft nodes before linearized reading' (duration: 615.242875ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:59:50.287507Z","caller":"traceutil/trace.go:171","msg":"trace[1103317032] range","detail":"{range_begin:/registry/pods/openstack/keepalived-6bppt; range_end:; response_count:1; response_revision:4890; }","duration":"254.901692ms","start":"2026-02-26T16:59:50.032589Z","end":"2026-02-26T16:59:50.287491Z","steps":["trace[1103317032] 'agreement among raft nodes before linearized reading' (duration: 254.691238ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:59:50.287519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.980521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d09b5033-8002-4a6b-b5d5-0a7310125b8e\" ","response":"range_response_count:1 size:3646"} {"level":"warn","ts":"2026-02-26T16:59:50.287544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:59:49.671963Z","time spent":"615.571792ms","remote":"127.0.0.1:59870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":1841,"request content":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" "} {"level":"info","ts":"2026-02-26T16:59:50.287585Z","caller":"traceutil/trace.go:171","msg":"trace[298064864] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d09b5033-8002-4a6b-b5d5-0a7310125b8e; range_end:; response_count:1; response_revision:4890; }","duration":"596.050852ms","start":"2026-02-26T16:59:49.691517Z","end":"2026-02-26T16:59:50.287568Z","steps":["trace[298064864] 'agreement among raft nodes before linearized reading' (duration: 595.858878ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:59:50.28764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:59:49.691481Z","time spent":"596.146694ms","remote":"127.0.0.1:59974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3670,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d09b5033-8002-4a6b-b5d5-0a7310125b8e\" "} {"level":"warn","ts":"2026-02-26T16:59:50.805243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.582227ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-26T16:59:50.805389Z","caller":"traceutil/trace.go:171","msg":"trace[1007065916] transaction","detail":"{read_only:false; response_revision:4891; number_of_response:1; }","duration":"512.739161ms","start":"2026-02-26T16:59:50.292606Z","end":"2026-02-26T16:59:50.805345Z","steps":["trace[1007065916] 'process raft request' (duration: 118.983691ms)","trace[1007065916] 'compare' (duration: 393.169159ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:59:50.80547Z","caller":"traceutil/trace.go:171","msg":"trace[1824619412] transaction","detail":"{read_only:false; response_revision:4894; number_of_response:1; }","duration":"502.113809ms","start":"2026-02-26T16:59:50.303341Z","end":"2026-02-26T16:59:50.805455Z","steps":["trace[1824619412] 'process raft request' (duration: 502.074248ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:59:50.805534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:59:50.303321Z","time spent":"502.18264ms","remote":"127.0.0.1:44242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7067,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T16:59:50.8055Z","caller":"traceutil/trace.go:171","msg":"trace[1486513003] transaction","detail":"{read_only:false; response_revision:4892; number_of_response:1; }","duration":"508.710101ms","start":"2026-02-26T16:59:50.29675Z","end":"2026-02-26T16:59:50.80546Z","steps":["trace[1486513003] 'process raft request' (duration: 508.576769ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:59:50.805563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:59:50.292589Z","time spent":"512.879765ms","remote":"127.0.0.1:59852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":909,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T16:59:50.805683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:59:50.296737Z","time spent":"508.863074ms","remote":"127.0.0.1:59852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":902,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T16:59:50.805728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.801252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:9 size:80091"} {"level":"info","ts":"2026-02-26T16:59:50.805769Z","caller":"traceutil/trace.go:171","msg":"trace[1905581394] transaction","detail":"{read_only:false; response_revision:4893; number_of_response:1; }","duration":"508.985897ms","start":"2026-02-26T16:59:50.296775Z","end":"2026-02-26T16:59:50.805761Z","steps":["trace[1905581394] 'process raft request' (duration: 508.60042ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:59:50.805767Z","caller":"traceutil/trace.go:171","msg":"trace[186729212] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:9; response_revision:4894; }","duration":"512.871034ms","start":"2026-02-26T16:59:50.292887Z","end":"2026-02-26T16:59:50.805758Z","steps":["trace[186729212] 'agreement among raft nodes before linearized reading' (duration: 512.567048ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:59:50.80581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:59:50.292871Z","time spent":"512.931095ms","remote":"127.0.0.1:59974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":9,"response size":80115,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"info","ts":"2026-02-26T16:59:50.805401Z","caller":"traceutil/trace.go:171","msg":"trace[1752659779] linearizableReadLoop","detail":"{readStateIndex:5080; appliedIndex:5079; }","duration":"512.466866ms","start":"2026-02-26T16:59:50.292914Z","end":"2026-02-26T16:59:50.805381Z","steps":["trace[1752659779] 'read index received' (duration: 118.672615ms)","trace[1752659779] 'applied index is now lower than readState.Index' (duration: 393.792481ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T16:59:50.805815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:59:50.296755Z","time spent":"509.039198ms","remote":"127.0.0.1:59974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3751,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T16:59:50.842928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.036111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-26T16:59:50.843008Z","caller":"traceutil/trace.go:171","msg":"trace[687694018] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:4895; }","duration":"436.159624ms","start":"2026-02-26T16:59:50.406832Z","end":"2026-02-26T16:59:50.842992Z","steps":["trace[687694018] 'agreement among raft nodes before linearized reading' (duration: 435.96573ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:59:50.842997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.409579ms","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-02-26T16:59:50.843028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.418713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-02-26T16:59:50.843058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.560322ms","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-02-26T16:59:50.843064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.475174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3565"} {"level":"info","ts":"2026-02-26T16:59:50.843122Z","caller":"traceutil/trace.go:171","msg":"trace[1882792636] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4895; }","duration":"445.678704ms","start":"2026-02-26T16:59:50.397428Z","end":"2026-02-26T16:59:50.843106Z","steps":["trace[1882792636] 'agreement among raft nodes before linearized reading' (duration: 445.531121ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:59:50.843138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.112869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d09b5033-8002-4a6b-b5d5-0a7310125b8e\" ","response":"range_response_count:1 size:3766"} {"level":"info","ts":"2026-02-26T16:59:50.843128Z","caller":"traceutil/trace.go:171","msg":"trace[1244809168] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:4895; }","duration":"528.533425ms","start":"2026-02-26T16:59:50.314569Z","end":"2026-02-26T16:59:50.843103Z","steps":["trace[1244809168] 'agreement among raft nodes before linearized reading' (duration: 528.348292ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:59:50.843142Z","caller":"traceutil/trace.go:171","msg":"trace[1283162969] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4895; }","duration":"536.580196ms","start":"2026-02-26T16:59:50.306541Z","end":"2026-02-26T16:59:50.843121Z","steps":["trace[1283162969] 'agreement among raft nodes before linearized reading' (duration: 536.343241ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:59:50.84316Z","caller":"traceutil/trace.go:171","msg":"trace[1486902001] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d09b5033-8002-4a6b-b5d5-0a7310125b8e; range_end:; response_count:1; response_revision:4895; }","duration":"197.17087ms","start":"2026-02-26T16:59:50.645982Z","end":"2026-02-26T16:59:50.843153Z","steps":["trace[1486902001] 'agreement among raft nodes before linearized reading' (duration: 197.121509ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:59:50.843161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:59:50.397402Z","time spent":"445.752406ms","remote":"127.0.0.1:60052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-26T16:59:50.843182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:59:50.314545Z","time spent":"528.621866ms","remote":"127.0.0.1:60052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":13,"response size":31,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"warn","ts":"2026-02-26T16:59:50.84319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.044602ms","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-02-26T16:59:50.843231Z","caller":"traceutil/trace.go:171","msg":"trace[788338243] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4895; }","duration":"446.117083ms","start":"2026-02-26T16:59:50.397106Z","end":"2026-02-26T16:59:50.843223Z","steps":["trace[788338243] 'agreement among raft nodes before linearized reading' (duration: 446.011211ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:59:50.843251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.003108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T16:59:50.843285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.302689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:16 size:110392"} {"level":"warn","ts":"2026-02-26T16:59:50.843326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.571952ms","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":"warn","ts":"2026-02-26T16:59:50.843353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.110668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-02-26T16:59:50.843361Z","caller":"traceutil/trace.go:171","msg":"trace[525781165] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:4895; }","duration":"276.752736ms","start":"2026-02-26T16:59:50.566596Z","end":"2026-02-26T16:59:50.843348Z","steps":["trace[525781165] 'agreement among raft nodes before linearized reading' (duration: 276.699575ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:59:50.843087Z","caller":"traceutil/trace.go:171","msg":"trace[433067092] transaction","detail":"{read_only:false; response_revision:4895; number_of_response:1; }","duration":"124.433ms","start":"2026-02-26T16:59:50.718644Z","end":"2026-02-26T16:59:50.843077Z","steps":["trace[433067092] 'process raft request' (duration: 123.977581ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:59:50.843393Z","caller":"traceutil/trace.go:171","msg":"trace[655944000] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4895; }","duration":"370.188409ms","start":"2026-02-26T16:59:50.473195Z","end":"2026-02-26T16:59:50.843384Z","steps":["trace[655944000] 'agreement among raft nodes before linearized reading' (duration: 370.093127ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:59:50.843303Z","caller":"traceutil/trace.go:171","msg":"trace[1705780797] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4895; }","duration":"327.072979ms","start":"2026-02-26T16:59:50.516217Z","end":"2026-02-26T16:59:50.84329Z","steps":["trace[1705780797] 'agreement among raft nodes before linearized reading' (duration: 327.000987ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:59:50.843421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:59:50.473173Z","time spent":"370.2409ms","remote":"127.0.0.1:60052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-02-26T16:59:50.843421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.293489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-02-26T16:59:50.843448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:59:50.516206Z","time spent":"327.234043ms","remote":"127.0.0.1:59796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-26T16:59:50.843464Z","caller":"traceutil/trace.go:171","msg":"trace[460235555] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4895; }","duration":"404.36214ms","start":"2026-02-26T16:59:50.439089Z","end":"2026-02-26T16:59:50.843451Z","steps":["trace[460235555] 'agreement among raft nodes before linearized reading' (duration: 404.241998ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:59:50.843265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:59:50.397087Z","time spent":"446.170674ms","remote":"127.0.0.1:60052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-26T16:59:50.843511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:59:50.439075Z","time spent":"404.426431ms","remote":"127.0.0.1:60052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-26T16:59:50.843362Z","caller":"traceutil/trace.go:171","msg":"trace[2019465293] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:16; response_revision:4895; }","duration":"550.393552ms","start":"2026-02-26T16:59:50.292951Z","end":"2026-02-26T16:59:50.843344Z","steps":["trace[2019465293] 'agreement among raft nodes before linearized reading' (duration: 550.013815ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:59:50.843191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:59:50.306526Z","time spent":"536.653858ms","remote":"127.0.0.1:59870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":3589,"request content":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" "} {"level":"warn","ts":"2026-02-26T16:59:50.843561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:59:50.292945Z","time spent":"550.604836ms","remote":"127.0.0.1:59974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":16,"response size":110416,"request content":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" "} {"level":"warn","ts":"2026-02-26T16:59:50.84305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:59:50.406821Z","time spent":"436.218045ms","remote":"127.0.0.1:44160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":31,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "} {"level":"info","ts":"2026-02-26T16:59:50.843087Z","caller":"traceutil/trace.go:171","msg":"trace[2112766709] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4895; }","duration":"452.537901ms","start":"2026-02-26T16:59:50.390532Z","end":"2026-02-26T16:59:50.84307Z","steps":["trace[2112766709] 'agreement among raft nodes before linearized reading' (duration: 452.287506ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:59:50.843668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T16:59:50.390521Z","time spent":"453.139182ms","remote":"127.0.0.1:60052","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-02-26T16:59:50.988508Z","caller":"traceutil/trace.go:171","msg":"trace[721329265] transaction","detail":"{read_only:false; response_revision:4897; number_of_response:1; }","duration":"140.106693ms","start":"2026-02-26T16:59:50.848376Z","end":"2026-02-26T16:59:50.988483Z","steps":["trace[721329265] 'process raft request' (duration: 75.572266ms)","trace[721329265] 'compare' (duration: 64.372944ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:59:50.988776Z","caller":"traceutil/trace.go:171","msg":"trace[1000095384] transaction","detail":"{read_only:false; response_revision:4898; number_of_response:1; }","duration":"140.339888ms","start":"2026-02-26T16:59:50.84839Z","end":"2026-02-26T16:59:50.98873Z","steps":["trace[1000095384] 'process raft request' (duration: 140.046162ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:59:50.98887Z","caller":"traceutil/trace.go:171","msg":"trace[466932797] transaction","detail":"{read_only:false; response_revision:4899; number_of_response:1; }","duration":"140.105553ms","start":"2026-02-26T16:59:50.848743Z","end":"2026-02-26T16:59:50.988848Z","steps":["trace[466932797] 'process raft request' (duration: 139.880018ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:59:50.989126Z","caller":"traceutil/trace.go:171","msg":"trace[394726970] transaction","detail":"{read_only:false; response_revision:4900; number_of_response:1; }","duration":"140.307527ms","start":"2026-02-26T16:59:50.848797Z","end":"2026-02-26T16:59:50.989105Z","steps":["trace[394726970] 'process raft request' (duration: 139.94447ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:59:50.989154Z","caller":"traceutil/trace.go:171","msg":"trace[568056360] linearizableReadLoop","detail":"{readStateIndex:5089; appliedIndex:5084; }","duration":"138.252546ms","start":"2026-02-26T16:59:50.850886Z","end":"2026-02-26T16:59:50.989139Z","steps":["trace[568056360] 'read index received' (duration: 45.16022ms)","trace[568056360] 'applied index is now lower than readState.Index' (duration: 93.091256ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:59:50.9893Z","caller":"traceutil/trace.go:171","msg":"trace[1196546977] transaction","detail":"{read_only:false; response_revision:4901; number_of_response:1; }","duration":"138.288896ms","start":"2026-02-26T16:59:50.850986Z","end":"2026-02-26T16:59:50.989275Z","steps":["trace[1196546977] 'process raft request' (duration: 137.825757ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:59:50.98941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.50167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3565"} {"level":"warn","ts":"2026-02-26T16:59:50.989431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.587763ms","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-02-26T16:59:50.989451Z","caller":"traceutil/trace.go:171","msg":"trace[468193513] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4901; }","duration":"138.589913ms","start":"2026-02-26T16:59:50.85085Z","end":"2026-02-26T16:59:50.98944Z","steps":["trace[468193513] 'agreement among raft nodes before linearized reading' (duration: 138.404649ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:59:50.989465Z","caller":"traceutil/trace.go:171","msg":"trace[1706356639] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4901; }","duration":"136.654515ms","start":"2026-02-26T16:59:50.852801Z","end":"2026-02-26T16:59:50.989456Z","steps":["trace[1706356639] 'agreement among raft nodes before linearized reading' (duration: 136.519391ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:59:50.989724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.801068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4867"} {"level":"info","ts":"2026-02-26T16:59:50.989772Z","caller":"traceutil/trace.go:171","msg":"trace[2136272661] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4901; }","duration":"134.8744ms","start":"2026-02-26T16:59:50.854886Z","end":"2026-02-26T16:59:50.98976Z","steps":["trace[2136272661] 'agreement among raft nodes before linearized reading' (duration: 134.709986ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:59:52.926627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.175186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-6bppt\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-02-26T16:59:52.926744Z","caller":"traceutil/trace.go:171","msg":"trace[1570304314] range","detail":"{range_begin:/registry/pods/openstack/keepalived-6bppt; range_end:; response_count:1; response_revision:4922; }","duration":"112.309149ms","start":"2026-02-26T16:59:52.814411Z","end":"2026-02-26T16:59:52.92672Z","steps":["trace[1570304314] 'range keys from in-memory index tree' (duration: 112.010904ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:59:52.926621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.316689ms","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-02-26T16:59:52.926853Z","caller":"traceutil/trace.go:171","msg":"trace[1252843841] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:4922; }","duration":"112.598344ms","start":"2026-02-26T16:59:52.814231Z","end":"2026-02-26T16:59:52.926829Z","steps":["trace[1252843841] 'range keys from in-memory index tree' (duration: 112.170867ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T16:59:58.081438Z","caller":"traceutil/trace.go:171","msg":"trace[2014637138] linearizableReadLoop","detail":"{readStateIndex:5202; appliedIndex:5201; }","duration":"243.640397ms","start":"2026-02-26T16:59:57.837777Z","end":"2026-02-26T16:59:58.081418Z","steps":["trace[2014637138] 'read index received' (duration: 243.391952ms)","trace[2014637138] 'applied index is now lower than readState.Index' (duration: 247.695µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T16:59:58.08149Z","caller":"traceutil/trace.go:171","msg":"trace[1960611382] transaction","detail":"{read_only:false; response_revision:5009; number_of_response:1; }","duration":"273.024222ms","start":"2026-02-26T16:59:57.808451Z","end":"2026-02-26T16:59:58.081475Z","steps":["trace[1960611382] 'process raft request' (duration: 272.836768ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:59:58.081675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.879852ms","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-02-26T16:59:58.08172Z","caller":"traceutil/trace.go:171","msg":"trace[16669487] 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:5009; }","duration":"243.966144ms","start":"2026-02-26T16:59:57.837741Z","end":"2026-02-26T16:59:58.081707Z","steps":["trace[16669487] 'agreement among raft nodes before linearized reading' (duration: 243.78791ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T16:59:58.081704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.857869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T16:59:58.081781Z","caller":"traceutil/trace.go:171","msg":"trace[2065335025] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5009; }","duration":"128.982932ms","start":"2026-02-26T16:59:57.952779Z","end":"2026-02-26T16:59:58.081762Z","steps":["trace[2065335025] 'agreement among raft nodes before linearized reading' (duration: 128.852629ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:00:01.989451Z","caller":"traceutil/trace.go:171","msg":"trace[577799341] transaction","detail":"{read_only:false; response_revision:5047; number_of_response:1; }","duration":"125.290707ms","start":"2026-02-26T17:00:01.86413Z","end":"2026-02-26T17:00:01.989421Z","steps":["trace[577799341] 'process raft request' (duration: 92.203828ms)","trace[577799341] 'compare' (duration: 32.978117ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:00:02.027143Z","caller":"traceutil/trace.go:171","msg":"trace[550620558] transaction","detail":"{read_only:false; response_revision:5048; number_of_response:1; }","duration":"162.751334ms","start":"2026-02-26T17:00:01.864365Z","end":"2026-02-26T17:00:02.027117Z","steps":["trace[550620558] 'process raft request' (duration: 162.584551ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:00:02.027448Z","caller":"traceutil/trace.go:171","msg":"trace[740965996] transaction","detail":"{read_only:false; response_revision:5049; number_of_response:1; }","duration":"162.988279ms","start":"2026-02-26T17:00:01.864447Z","end":"2026-02-26T17:00:02.027435Z","steps":["trace[740965996] 'process raft request' (duration: 162.629132ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:00:02.027482Z","caller":"traceutil/trace.go:171","msg":"trace[2146679676] transaction","detail":"{read_only:false; response_revision:5050; number_of_response:1; }","duration":"162.662632ms","start":"2026-02-26T17:00:01.864798Z","end":"2026-02-26T17:00:02.02746Z","steps":["trace[2146679676] 'process raft request' (duration: 162.458928ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:00:02.4816Z","caller":"traceutil/trace.go:171","msg":"trace[1808725607] transaction","detail":"{read_only:false; response_revision:5051; number_of_response:1; }","duration":"152.669044ms","start":"2026-02-26T17:00:02.328901Z","end":"2026-02-26T17:00:02.48157Z","steps":["trace[1808725607] 'process raft request' (duration: 152.390548ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:01:25.586416Z","caller":"traceutil/trace.go:171","msg":"trace[621748448] linearizableReadLoop","detail":"{readStateIndex:5825; appliedIndex:5824; }","duration":"113.438822ms","start":"2026-02-26T17:01:25.472945Z","end":"2026-02-26T17:01:25.586384Z","steps":["trace[621748448] 'read index received' (duration: 110.009832ms)","trace[621748448] 'applied index is now lower than readState.Index' (duration: 3.42778ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:01:25.586448Z","caller":"traceutil/trace.go:171","msg":"trace[1864642211] transaction","detail":"{read_only:false; response_revision:5613; number_of_response:1; }","duration":"133.448736ms","start":"2026-02-26T17:01:25.452975Z","end":"2026-02-26T17:01:25.586424Z","steps":["trace[1864642211] 'process raft request' (duration: 129.965565ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:01:25.586877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.822529ms","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-02-26T17:01:25.58697Z","caller":"traceutil/trace.go:171","msg":"trace[750012126] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5613; }","duration":"112.958412ms","start":"2026-02-26T17:01:25.473994Z","end":"2026-02-26T17:01:25.586953Z","steps":["trace[750012126] 'agreement among raft nodes before linearized reading' (duration: 112.646795ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:01:25.586986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.765378ms","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-02-26T17:01:25.587036Z","caller":"traceutil/trace.go:171","msg":"trace[398563853] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5613; }","duration":"108.821049ms","start":"2026-02-26T17:01:25.478201Z","end":"2026-02-26T17:01:25.587022Z","steps":["trace[398563853] 'agreement among raft nodes before linearized reading' (duration: 108.694136ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:01:25.586958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.984123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-02-26T17:01:25.587159Z","caller":"traceutil/trace.go:171","msg":"trace[825964228] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5613; }","duration":"114.160736ms","start":"2026-02-26T17:01:25.472925Z","end":"2026-02-26T17:01:25.587085Z","steps":["trace[825964228] 'agreement among raft nodes before linearized reading' (duration: 113.617545ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:01:44.143977Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2784} {"level":"info","ts":"2026-02-26T17:01:44.212371Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2784,"took":"66.142927ms","hash":580603833,"current-db-size-bytes":41553920,"current-db-size":"42 MB","current-db-size-in-use-bytes":31318016,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-02-26T17:01:44.212478Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":580603833,"revision":2784,"compact-revision":-1} {"level":"info","ts":"2026-02-26T17:05:30.942181Z","caller":"traceutil/trace.go:171","msg":"trace[717882289] linearizableReadLoop","detail":"{readStateIndex:7576; appliedIndex:7575; }","duration":"108.494668ms","start":"2026-02-26T17:05:30.833661Z","end":"2026-02-26T17:05:30.942156Z","steps":["trace[717882289] 'read index received' (duration: 108.277364ms)","trace[717882289] 'applied index is now lower than readState.Index' (duration: 216.254µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:05:30.942318Z","caller":"traceutil/trace.go:171","msg":"trace[530858237] transaction","detail":"{read_only:false; response_revision:7303; number_of_response:1; }","duration":"158.242541ms","start":"2026-02-26T17:05:30.784063Z","end":"2026-02-26T17:05:30.942306Z","steps":["trace[530858237] 'process raft request' (duration: 157.946455ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:05:30.942724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.018738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-6bppt\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-02-26T17:05:30.942769Z","caller":"traceutil/trace.go:171","msg":"trace[2091965983] range","detail":"{range_begin:/registry/pods/openstack/keepalived-6bppt; range_end:; response_count:1; response_revision:7303; }","duration":"109.153791ms","start":"2026-02-26T17:05:30.833603Z","end":"2026-02-26T17:05:30.942757Z","steps":["trace[2091965983] 'agreement among raft nodes before linearized reading' (duration: 108.970688ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:05:42.611094Z","caller":"traceutil/trace.go:171","msg":"trace[570329218] linearizableReadLoop","detail":"{readStateIndex:7763; appliedIndex:7762; }","duration":"282.960785ms","start":"2026-02-26T17:05:42.328105Z","end":"2026-02-26T17:05:42.611065Z","steps":["trace[570329218] 'read index received' (duration: 282.869783ms)","trace[570329218] 'applied index is now lower than readState.Index' (duration: 89.592µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:05:42.611194Z","caller":"traceutil/trace.go:171","msg":"trace[1494016201] transaction","detail":"{read_only:false; response_revision:7487; number_of_response:1; }","duration":"375.294078ms","start":"2026-02-26T17:05:42.235861Z","end":"2026-02-26T17:05:42.611155Z","steps":["trace[1494016201] 'process raft request' (duration: 375.055624ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:05:42.611329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.20732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1633"} {"level":"warn","ts":"2026-02-26T17:05:42.611356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:05:42.235828Z","time spent":"375.426113ms","remote":"127.0.0.1:60052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T17:05:42.61139Z","caller":"traceutil/trace.go:171","msg":"trace[1792227625] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:7487; }","duration":"283.323743ms","start":"2026-02-26T17:05:42.328048Z","end":"2026-02-26T17:05:42.611372Z","steps":["trace[1792227625] 'agreement among raft nodes before linearized reading' (duration: 283.142538ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:05:42.921357Z","caller":"traceutil/trace.go:171","msg":"trace[1771079371] linearizableReadLoop","detail":"{readStateIndex:7764; appliedIndex:7763; }","duration":"307.183438ms","start":"2026-02-26T17:05:42.614145Z","end":"2026-02-26T17:05:42.921329Z","steps":["trace[1771079371] 'read index received' (duration: 304.740508ms)","trace[1771079371] 'applied index is now lower than readState.Index' (duration: 2.44155ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:05:42.921502Z","caller":"traceutil/trace.go:171","msg":"trace[1141159489] transaction","detail":"{read_only:false; response_revision:7488; number_of_response:1; }","duration":"380.118955ms","start":"2026-02-26T17:05:42.541366Z","end":"2026-02-26T17:05:42.921485Z","steps":["trace[1141159489] 'process raft request' (duration: 377.504012ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:05:42.921656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:05:42.541339Z","time spent":"380.221317ms","remote":"127.0.0.1:60052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T17:05:42.923563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.666999ms","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-02-26T17:05:42.923621Z","caller":"traceutil/trace.go:171","msg":"trace[449821016] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7488; }","duration":"225.769841ms","start":"2026-02-26T17:05:42.697838Z","end":"2026-02-26T17:05:42.923608Z","steps":["trace[449821016] 'agreement among raft nodes before linearized reading' (duration: 225.607548ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:05:42.923619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.504294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-94cade5a-4add-4a63-a96c-e5269a7de026\" ","response":"range_response_count:1 size:1293"} {"level":"info","ts":"2026-02-26T17:05:42.92367Z","caller":"traceutil/trace.go:171","msg":"trace[82455065] range","detail":"{range_begin:/registry/persistentvolumes/pvc-94cade5a-4add-4a63-a96c-e5269a7de026; range_end:; response_count:1; response_revision:7488; }","duration":"309.581915ms","start":"2026-02-26T17:05:42.614073Z","end":"2026-02-26T17:05:42.923655Z","steps":["trace[82455065] 'agreement among raft nodes before linearized reading' (duration: 307.502103ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:05:42.923712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:05:42.61406Z","time spent":"309.644286ms","remote":"127.0.0.1:59938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1317,"request content":"key:\"/registry/persistentvolumes/pvc-94cade5a-4add-4a63-a96c-e5269a7de026\" "} {"level":"warn","ts":"2026-02-26T17:05:42.923822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.905364ms","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-02-26T17:05:42.923859Z","caller":"traceutil/trace.go:171","msg":"trace[824794845] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7488; }","duration":"171.965716ms","start":"2026-02-26T17:05:42.751885Z","end":"2026-02-26T17:05:42.923851Z","steps":["trace[824794845] 'agreement among raft nodes before linearized reading' (duration: 171.877034ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:05:42.924022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.516436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12211"} {"level":"info","ts":"2026-02-26T17:05:42.924061Z","caller":"traceutil/trace.go:171","msg":"trace[38962392] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:7488; }","duration":"172.595718ms","start":"2026-02-26T17:05:42.751456Z","end":"2026-02-26T17:05:42.924052Z","steps":["trace[38962392] 'agreement among raft nodes before linearized reading' (duration: 172.492196ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:05:49.162092Z","caller":"traceutil/trace.go:171","msg":"trace[1092171266] linearizableReadLoop","detail":"{readStateIndex:7798; appliedIndex:7796; }","duration":"111.905146ms","start":"2026-02-26T17:05:49.050159Z","end":"2026-02-26T17:05:49.162064Z","steps":["trace[1092171266] 'read index received' (duration: 68.188372ms)","trace[1092171266] 'applied index is now lower than readState.Index' (duration: 43.715364ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:05:49.16216Z","caller":"traceutil/trace.go:171","msg":"trace[1512418531] transaction","detail":"{read_only:false; response_revision:7520; number_of_response:1; }","duration":"129.194202ms","start":"2026-02-26T17:05:49.032929Z","end":"2026-02-26T17:05:49.162123Z","steps":["trace[1512418531] 'process raft request' (duration: 128.999408ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:05:49.162383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.519518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-02-26T17:05:49.162452Z","caller":"traceutil/trace.go:171","msg":"trace[233543150] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:7520; }","duration":"101.62023ms","start":"2026-02-26T17:05:49.060815Z","end":"2026-02-26T17:05:49.162435Z","steps":["trace[233543150] 'agreement among raft nodes before linearized reading' (duration: 101.443236ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:05:49.162487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.991188ms","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-02-26T17:05:49.162542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.147571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-6bppt\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-02-26T17:05:49.162573Z","caller":"traceutil/trace.go:171","msg":"trace[455474128] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7520; }","duration":"109.12298ms","start":"2026-02-26T17:05:49.053431Z","end":"2026-02-26T17:05:49.162554Z","steps":["trace[455474128] 'agreement among raft nodes before linearized reading' (duration: 108.832074ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:05:49.162595Z","caller":"traceutil/trace.go:171","msg":"trace[1248970179] range","detail":"{range_begin:/registry/pods/openstack/keepalived-6bppt; range_end:; response_count:1; response_revision:7520; }","duration":"112.453907ms","start":"2026-02-26T17:05:49.050124Z","end":"2026-02-26T17:05:49.162578Z","steps":["trace[1248970179] 'agreement among raft nodes before linearized reading' (duration: 112.071729ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:05:53.536172Z","caller":"traceutil/trace.go:171","msg":"trace[1691505557] linearizableReadLoop","detail":"{readStateIndex:7818; appliedIndex:7817; }","duration":"238.968555ms","start":"2026-02-26T17:05:53.297178Z","end":"2026-02-26T17:05:53.536147Z","steps":["trace[1691505557] 'read index received' (duration: 238.799861ms)","trace[1691505557] 'applied index is now lower than readState.Index' (duration: 167.474µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:05:53.536215Z","caller":"traceutil/trace.go:171","msg":"trace[1196163922] transaction","detail":"{read_only:false; response_revision:7539; number_of_response:1; }","duration":"239.034795ms","start":"2026-02-26T17:05:53.297154Z","end":"2026-02-26T17:05:53.536188Z","steps":["trace[1196163922] 'process raft request' (duration: 238.844412ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:05:53.53635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.150488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:05:53.53639Z","caller":"traceutil/trace.go:171","msg":"trace[1805717403] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:7539; }","duration":"239.228269ms","start":"2026-02-26T17:05:53.297151Z","end":"2026-02-26T17:05:53.536379Z","steps":["trace[1805717403] 'agreement among raft nodes before linearized reading' (duration: 239.142478ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:05:53.536452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.159288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:05:53.536515Z","caller":"traceutil/trace.go:171","msg":"trace[608835883] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:7539; }","duration":"239.237139ms","start":"2026-02-26T17:05:53.297257Z","end":"2026-02-26T17:05:53.536494Z","steps":["trace[608835883] 'agreement among raft nodes before linearized reading' (duration: 239.146068ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:05:53.536644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.07996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:05:53.536677Z","caller":"traceutil/trace.go:171","msg":"trace[2093037836] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:7539; }","duration":"124.126321ms","start":"2026-02-26T17:05:53.41254Z","end":"2026-02-26T17:05:53.536667Z","steps":["trace[2093037836] 'agreement among raft nodes before linearized reading' (duration: 124.07439ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:05:53.536753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.772633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:05:53.536806Z","caller":"traceutil/trace.go:171","msg":"trace[1759656395] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:7539; }","duration":"124.847595ms","start":"2026-02-26T17:05:53.41194Z","end":"2026-02-26T17:05:53.536788Z","steps":["trace[1759656395] 'agreement among raft nodes before linearized reading' (duration: 124.768004ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:05:53.537017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.08931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:05:53.537063Z","caller":"traceutil/trace.go:171","msg":"trace[1413324921] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:7539; }","duration":"125.147661ms","start":"2026-02-26T17:05:53.411902Z","end":"2026-02-26T17:05:53.537049Z","steps":["trace[1413324921] 'agreement among raft nodes before linearized reading' (duration: 125.07203ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:05:53.53739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.472158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:05:53.537472Z","caller":"traceutil/trace.go:171","msg":"trace[199124545] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:7539; }","duration":"108.59956ms","start":"2026-02-26T17:05:53.428834Z","end":"2026-02-26T17:05:53.537434Z","steps":["trace[199124545] 'agreement among raft nodes before linearized reading' (duration: 108.446507ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:05:53.537735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.049847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:05:53.537825Z","caller":"traceutil/trace.go:171","msg":"trace[1799451132] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:7539; }","duration":"191.160609ms","start":"2026-02-26T17:05:53.346642Z","end":"2026-02-26T17:05:53.537802Z","steps":["trace[1799451132] 'agreement among raft nodes before linearized reading' (duration: 191.041517ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:05:53.537805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.884594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T17:05:53.537826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.418815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T17:05:53.537882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.776291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-6bppt\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-02-26T17:05:53.537912Z","caller":"traceutil/trace.go:171","msg":"trace[846050815] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:7539; }","duration":"176.534148ms","start":"2026-02-26T17:05:53.361355Z","end":"2026-02-26T17:05:53.537889Z","steps":["trace[846050815] 'agreement among raft nodes before linearized reading' (duration: 176.421426ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:05:53.537925Z","caller":"traceutil/trace.go:171","msg":"trace[2130983735] range","detail":"{range_begin:/registry/pods/openstack/keepalived-6bppt; range_end:; response_count:1; response_revision:7539; }","duration":"229.861003ms","start":"2026-02-26T17:05:53.308053Z","end":"2026-02-26T17:05:53.537914Z","steps":["trace[2130983735] 'agreement among raft nodes before linearized reading' (duration: 229.71688ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:05:53.537942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.999938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T17:05:53.537946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.54745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:05:53.537975Z","caller":"traceutil/trace.go:171","msg":"trace[1566540598] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:7539; }","duration":"141.050058ms","start":"2026-02-26T17:05:53.396913Z","end":"2026-02-26T17:05:53.537964Z","steps":["trace[1566540598] 'agreement among raft nodes before linearized reading' (duration: 140.997867ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:05:53.537998Z","caller":"traceutil/trace.go:171","msg":"trace[525288058] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:7539; }","duration":"108.608851ms","start":"2026-02-26T17:05:53.429374Z","end":"2026-02-26T17:05:53.537983Z","steps":["trace[525288058] 'agreement among raft nodes before linearized reading' (duration: 108.532399ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:05:53.538013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.67034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T17:05:53.538123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.489336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T17:05:53.538142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.14016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T17:05:53.538106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.11755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:05:53.538159Z","caller":"traceutil/trace.go:171","msg":"trace[1315548530] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:7539; }","duration":"191.566278ms","start":"2026-02-26T17:05:53.346583Z","end":"2026-02-26T17:05:53.538149Z","steps":["trace[1315548530] 'agreement among raft nodes before linearized reading' (duration: 191.502917ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:05:53.538172Z","caller":"traceutil/trace.go:171","msg":"trace[644934813] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:7539; }","duration":"176.18171ms","start":"2026-02-26T17:05:53.361981Z","end":"2026-02-26T17:05:53.538163Z","steps":["trace[644934813] 'agreement among raft nodes before linearized reading' (duration: 176.139119ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:05:53.538181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.192822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:05:53.538209Z","caller":"traceutil/trace.go:171","msg":"trace[268251386] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:7539; }","duration":"142.250472ms","start":"2026-02-26T17:05:53.395933Z","end":"2026-02-26T17:05:53.538183Z","steps":["trace[268251386] 'agreement among raft nodes before linearized reading' (duration: 142.078499ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:05:53.538246Z","caller":"traceutil/trace.go:171","msg":"trace[158826420] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:7539; }","duration":"109.253973ms","start":"2026-02-26T17:05:53.428972Z","end":"2026-02-26T17:05:53.538226Z","steps":["trace[158826420] 'agreement among raft nodes before linearized reading' (duration: 109.171332ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:05:53.538313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.2151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:05:53.538345Z","caller":"traceutil/trace.go:171","msg":"trace[2015245904] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:7539; }","duration":"224.257001ms","start":"2026-02-26T17:05:53.314078Z","end":"2026-02-26T17:05:53.538335Z","steps":["trace[2015245904] 'agreement among raft nodes before linearized reading' (duration: 224.209671ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:05:53.538362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.343195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:05:53.538398Z","caller":"traceutil/trace.go:171","msg":"trace[1931376557] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:7539; }","duration":"142.400815ms","start":"2026-02-26T17:05:53.395987Z","end":"2026-02-26T17:05:53.538388Z","steps":["trace[1931376557] 'agreement among raft nodes before linearized reading' (duration: 142.344594ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:05:53.538099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.246913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T17:05:53.538465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.197801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T17:05:53.538203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.521357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:05:53.538506Z","caller":"traceutil/trace.go:171","msg":"trace[1097415477] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstoreusers/; range_end:/registry/ceph.rook.io/cephobjectstoreusers0; response_count:0; response_revision:7539; }","duration":"161.249272ms","start":"2026-02-26T17:05:53.377247Z","end":"2026-02-26T17:05:53.538496Z","steps":["trace[1097415477] 'agreement among raft nodes before linearized reading' (duration: 161.19177ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:05:53.538513Z","caller":"traceutil/trace.go:171","msg":"trace[914874154] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstoreusers/; range_end:/registry/ceph.rook.io/cephobjectstoreusers0; response_count:0; response_revision:7539; }","duration":"161.679841ms","start":"2026-02-26T17:05:53.376814Z","end":"2026-02-26T17:05:53.538494Z","steps":["trace[914874154] 'agreement among raft nodes before linearized reading' (duration: 161.252622ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:05:53.53854Z","caller":"traceutil/trace.go:171","msg":"trace[1007167693] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:7539; }","duration":"191.854613ms","start":"2026-02-26T17:05:53.346663Z","end":"2026-02-26T17:05:53.538518Z","steps":["trace[1007167693] 'agreement among raft nodes before linearized reading' (duration: 191.512716ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:05:53.538142Z","caller":"traceutil/trace.go:171","msg":"trace[334481555] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:7539; }","duration":"176.793702ms","start":"2026-02-26T17:05:53.361331Z","end":"2026-02-26T17:05:53.538125Z","steps":["trace[334481555] 'agreement among raft nodes before linearized reading' (duration: 176.65297ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:05:53.538599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.910843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:05:53.53865Z","caller":"traceutil/trace.go:171","msg":"trace[656955118] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:7539; }","duration":"224.971865ms","start":"2026-02-26T17:05:53.313668Z","end":"2026-02-26T17:05:53.53864Z","steps":["trace[656955118] 'agreement among raft nodes before linearized reading' (duration: 224.913484ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:05:53.538559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.828003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:05:53.537884Z","caller":"traceutil/trace.go:171","msg":"trace[1728104444] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstoreusers/; range_end:/registry/ceph.rook.io/cephobjectstoreusers0; response_count:0; response_revision:7539; }","duration":"161.001207ms","start":"2026-02-26T17:05:53.376863Z","end":"2026-02-26T17:05:53.537864Z","steps":["trace[1728104444] 'agreement among raft nodes before linearized reading' (duration: 160.880935ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:05:53.53884Z","caller":"traceutil/trace.go:171","msg":"trace[686753540] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:7539; }","duration":"225.112048ms","start":"2026-02-26T17:05:53.313711Z","end":"2026-02-26T17:05:53.538823Z","steps":["trace[686753540] 'agreement among raft nodes before linearized reading' (duration: 224.817722ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:05:53.539046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.840752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"warn","ts":"2026-02-26T17:05:53.539075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.003826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:05:53.539098Z","caller":"traceutil/trace.go:171","msg":"trace[368107253] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:7539; }","duration":"240.906803ms","start":"2026-02-26T17:05:53.298176Z","end":"2026-02-26T17:05:53.539083Z","steps":["trace[368107253] 'agreement among raft nodes before linearized reading' (duration: 240.789051ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:05:53.53912Z","caller":"traceutil/trace.go:171","msg":"trace[567236847] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:7539; }","duration":"241.067217ms","start":"2026-02-26T17:05:53.298039Z","end":"2026-02-26T17:05:53.539106Z","steps":["trace[567236847] 'agreement among raft nodes before linearized reading' (duration: 240.973335ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:06:07.181009Z","caller":"traceutil/trace.go:171","msg":"trace[662796607] transaction","detail":"{read_only:false; response_revision:7609; number_of_response:1; }","duration":"104.049079ms","start":"2026-02-26T17:06:07.076926Z","end":"2026-02-26T17:06:07.180975Z","steps":["trace[662796607] 'process raft request' (duration: 103.810745ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:06:07.307568Z","caller":"traceutil/trace.go:171","msg":"trace[2107150] transaction","detail":"{read_only:false; response_revision:7610; number_of_response:1; }","duration":"229.300082ms","start":"2026-02-26T17:06:07.078236Z","end":"2026-02-26T17:06:07.307536Z","steps":["trace[2107150] 'process raft request' (duration: 227.056068ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:06:19.531287Z","caller":"traceutil/trace.go:171","msg":"trace[769422357] linearizableReadLoop","detail":"{readStateIndex:8006; appliedIndex:8005; }","duration":"176.342973ms","start":"2026-02-26T17:06:19.354904Z","end":"2026-02-26T17:06:19.531247Z","steps":["trace[769422357] 'read index received' (duration: 176.039648ms)","trace[769422357] 'applied index is now lower than readState.Index' (duration: 302.305µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:06:19.531804Z","caller":"traceutil/trace.go:171","msg":"trace[133882327] transaction","detail":"{read_only:false; response_revision:7719; number_of_response:1; }","duration":"284.498605ms","start":"2026-02-26T17:06:19.247286Z","end":"2026-02-26T17:06:19.531784Z","steps":["trace[133882327] 'process raft request' (duration: 283.759441ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:06:19.532215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.281242ms","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-02-26T17:06:19.53227Z","caller":"traceutil/trace.go:171","msg":"trace[567135115] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7719; }","duration":"177.388584ms","start":"2026-02-26T17:06:19.35487Z","end":"2026-02-26T17:06:19.532258Z","steps":["trace[567135115] 'agreement among raft nodes before linearized reading' (duration: 177.17174ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:06:19.5325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.256392ms","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-02-26T17:06:19.532543Z","caller":"traceutil/trace.go:171","msg":"trace[1526712488] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7719; }","duration":"161.330523ms","start":"2026-02-26T17:06:19.3712Z","end":"2026-02-26T17:06:19.532531Z","steps":["trace[1526712488] 'agreement among raft nodes before linearized reading' (duration: 161.228261ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:06:19.532849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.448235ms","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-02-26T17:06:19.532932Z","caller":"traceutil/trace.go:171","msg":"trace[1372131019] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7719; }","duration":"158.570508ms","start":"2026-02-26T17:06:19.374344Z","end":"2026-02-26T17:06:19.532914Z","steps":["trace[1372131019] 'agreement among raft nodes before linearized reading' (duration: 158.354104ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:06:19.799927Z","caller":"traceutil/trace.go:171","msg":"trace[839039790] transaction","detail":"{read_only:false; response_revision:7720; number_of_response:1; }","duration":"262.041997ms","start":"2026-02-26T17:06:19.537856Z","end":"2026-02-26T17:06:19.799898Z","steps":["trace[839039790] 'process raft request' (duration: 199.127339ms)","trace[839039790] 'compare' (duration: 62.695773ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:06:19.80182Z","caller":"traceutil/trace.go:171","msg":"trace[1994938744] linearizableReadLoop","detail":"{readStateIndex:8009; appliedIndex:8006; }","duration":"159.206061ms","start":"2026-02-26T17:06:19.642591Z","end":"2026-02-26T17:06:19.801797Z","steps":["trace[1994938744] 'read index received' (duration: 94.389996ms)","trace[1994938744] 'applied index is now lower than readState.Index' (duration: 64.815005ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:06:19.801875Z","caller":"traceutil/trace.go:171","msg":"trace[1384745740] transaction","detail":"{read_only:false; response_revision:7721; number_of_response:1; }","duration":"262.616937ms","start":"2026-02-26T17:06:19.539225Z","end":"2026-02-26T17:06:19.801842Z","steps":["trace[1384745740] 'process raft request' (duration: 262.431513ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:06:19.801944Z","caller":"traceutil/trace.go:171","msg":"trace[489575948] transaction","detail":"{read_only:false; response_revision:7722; number_of_response:1; }","duration":"262.398113ms","start":"2026-02-26T17:06:19.539534Z","end":"2026-02-26T17:06:19.801932Z","steps":["trace[489575948] 'process raft request' (duration: 262.225749ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:06:19.802375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.762593ms","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-02-26T17:06:19.802431Z","caller":"traceutil/trace.go:171","msg":"trace[1096196237] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7722; }","duration":"159.868685ms","start":"2026-02-26T17:06:19.642549Z","end":"2026-02-26T17:06:19.802418Z","steps":["trace[1096196237] 'agreement among raft nodes before linearized reading' (duration: 159.690582ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:06:19.80276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.656851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-02-26T17:06:19.802818Z","caller":"traceutil/trace.go:171","msg":"trace[1186749170] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:7722; }","duration":"125.719573ms","start":"2026-02-26T17:06:19.677084Z","end":"2026-02-26T17:06:19.802803Z","steps":["trace[1186749170] 'agreement among raft nodes before linearized reading' (duration: 125.145912ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:06:31.680546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.729821ms","expected-duration":"100ms","prefix":"","request":"header: txn: success: > failure: >>","response":"size:18"} {"level":"info","ts":"2026-02-26T17:06:31.680674Z","caller":"traceutil/trace.go:171","msg":"trace[1565172721] transaction","detail":"{read_only:false; number_of_response:1; response_revision:7816; }","duration":"335.435953ms","start":"2026-02-26T17:06:31.345216Z","end":"2026-02-26T17:06:31.680652Z","steps":["trace[1565172721] 'process raft request' (duration: 189.432686ms)","trace[1565172721] 'compare' (duration: 145.19292ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T17:06:31.68079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:06:31.345206Z","time spent":"335.513494ms","remote":"127.0.0.1:44168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80,"response count":0,"response size":42,"request content":"compare: success: > failure: >"} {"level":"info","ts":"2026-02-26T17:06:31.68661Z","caller":"traceutil/trace.go:171","msg":"trace[129603400] linearizableReadLoop","detail":"{readStateIndex:8108; appliedIndex:8106; }","duration":"170.482907ms","start":"2026-02-26T17:06:31.51611Z","end":"2026-02-26T17:06:31.686592Z","steps":["trace[129603400] 'read index received' (duration: 18.632023ms)","trace[129603400] 'applied index is now lower than readState.Index' (duration: 151.850194ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:06:31.686676Z","caller":"traceutil/trace.go:171","msg":"trace[620220349] transaction","detail":"{read_only:false; response_revision:7817; number_of_response:1; }","duration":"340.884752ms","start":"2026-02-26T17:06:31.345762Z","end":"2026-02-26T17:06:31.686647Z","steps":["trace[620220349] 'process raft request' (duration: 340.721848ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:06:31.686765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.641899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:06:31.686801Z","caller":"traceutil/trace.go:171","msg":"trace[1361313965] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7817; }","duration":"170.737672ms","start":"2026-02-26T17:06:31.516053Z","end":"2026-02-26T17:06:31.686791Z","steps":["trace[1361313965] 'agreement among raft nodes before linearized reading' (duration: 170.66446ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:06:31.686897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.773703ms","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-02-26T17:06:31.686898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:06:31.34574Z","time spent":"341.055576ms","remote":"127.0.0.1:59974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4633,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T17:06:31.686965Z","caller":"traceutil/trace.go:171","msg":"trace[897708088] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7817; }","duration":"106.872786ms","start":"2026-02-26T17:06:31.580073Z","end":"2026-02-26T17:06:31.686946Z","steps":["trace[897708088] 'agreement among raft nodes before linearized reading' (duration: 106.681842ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:06:32.443839Z","caller":"traceutil/trace.go:171","msg":"trace[1972565511] transaction","detail":"{read_only:false; response_revision:7827; number_of_response:1; }","duration":"143.264892ms","start":"2026-02-26T17:06:32.30054Z","end":"2026-02-26T17:06:32.443805Z","steps":["trace[1972565511] 'process raft request' (duration: 143.044238ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:06:32.850997Z","caller":"traceutil/trace.go:171","msg":"trace[1773371835] linearizableReadLoop","detail":"{readStateIndex:8119; appliedIndex:8118; }","duration":"402.379592ms","start":"2026-02-26T17:06:32.448594Z","end":"2026-02-26T17:06:32.850974Z","steps":["trace[1773371835] 'read index received' (duration: 402.311409ms)","trace[1773371835] 'applied index is now lower than readState.Index' (duration: 60.592µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:06:32.851112Z","caller":"traceutil/trace.go:171","msg":"trace[439175011] transaction","detail":"{read_only:false; response_revision:7828; number_of_response:1; }","duration":"521.301368ms","start":"2026-02-26T17:06:32.329781Z","end":"2026-02-26T17:06:32.851082Z","steps":["trace[439175011] 'process raft request' (duration: 521.045652ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:06:32.851228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.622756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-config-override\" ","response":"range_response_count:1 size:626"} {"level":"info","ts":"2026-02-26T17:06:32.851273Z","caller":"traceutil/trace.go:171","msg":"trace[1440619930] range","detail":"{range_begin:/registry/configmaps/openstack/rook-config-override; range_end:; response_count:1; response_revision:7828; }","duration":"402.723158ms","start":"2026-02-26T17:06:32.448538Z","end":"2026-02-26T17:06:32.851261Z","steps":["trace[1440619930] 'agreement among raft nodes before linearized reading' (duration: 402.534575ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:06:32.85127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:06:32.329767Z","time spent":"521.41501ms","remote":"127.0.0.1:60022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3037,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T17:06:32.851312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:06:32.448518Z","time spent":"402.785059ms","remote":"127.0.0.1:59886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":650,"request content":"key:\"/registry/configmaps/openstack/rook-config-override\" "} {"level":"warn","ts":"2026-02-26T17:06:34.062989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.433544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"warn","ts":"2026-02-26T17:06:34.063011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.475255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-02-26T17:06:34.063048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.386153ms","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-02-26T17:06:34.063122Z","caller":"traceutil/trace.go:171","msg":"trace[987692347] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7832; }","duration":"133.505476ms","start":"2026-02-26T17:06:33.9296Z","end":"2026-02-26T17:06:34.063105Z","steps":["trace[987692347] 'range keys from in-memory index tree' (duration: 133.238531ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:06:34.063143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.277531ms","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-02-26T17:06:34.063125Z","caller":"traceutil/trace.go:171","msg":"trace[1569265937] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7832; }","duration":"139.616498ms","start":"2026-02-26T17:06:33.923482Z","end":"2026-02-26T17:06:34.063098Z","steps":["trace[1569265937] 'range keys from in-memory index tree' (duration: 139.289022ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:06:34.063174Z","caller":"traceutil/trace.go:171","msg":"trace[667757857] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7832; }","duration":"134.327513ms","start":"2026-02-26T17:06:33.928839Z","end":"2026-02-26T17:06:34.063166Z","steps":["trace[667757857] 'range keys from in-memory index tree' (duration: 134.17886ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:06:34.063064Z","caller":"traceutil/trace.go:171","msg":"trace[992445337] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:7832; }","duration":"133.538077ms","start":"2026-02-26T17:06:33.929508Z","end":"2026-02-26T17:06:34.063046Z","steps":["trace[992445337] 'range keys from in-memory index tree' (duration: 133.312372ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:06:34.063266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.964285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-6bppt\" ","response":"range_response_count:1 size:6524"} {"level":"warn","ts":"2026-02-26T17:06:34.063332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.869649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:06:34.0634Z","caller":"traceutil/trace.go:171","msg":"trace[1824746611] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:7832; }","duration":"179.96487ms","start":"2026-02-26T17:06:33.88342Z","end":"2026-02-26T17:06:34.063385Z","steps":["trace[1824746611] 'range keys from in-memory index tree' (duration: 179.774927ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:06:34.063339Z","caller":"traceutil/trace.go:171","msg":"trace[856346260] range","detail":"{range_begin:/registry/pods/openstack/keepalived-6bppt; range_end:; response_count:1; response_revision:7832; }","duration":"127.091638ms","start":"2026-02-26T17:06:33.93623Z","end":"2026-02-26T17:06:34.063321Z","steps":["trace[856346260] 'range keys from in-memory index tree' (duration: 126.769472ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:06:34.063472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.846946ms","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-02-26T17:06:34.063314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.780725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-26T17:06:34.06356Z","caller":"traceutil/trace.go:171","msg":"trace[2145227119] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7832; }","duration":"201.936957ms","start":"2026-02-26T17:06:33.861604Z","end":"2026-02-26T17:06:34.06354Z","steps":["trace[2145227119] 'range keys from in-memory index tree' (duration: 201.675923ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:06:34.063595Z","caller":"traceutil/trace.go:171","msg":"trace[707915315] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:7832; }","duration":"202.116091ms","start":"2026-02-26T17:06:33.861466Z","end":"2026-02-26T17:06:34.063582Z","steps":["trace[707915315] 'count revisions from in-memory index tree' (duration: 201.694753ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:06:34.181199Z","caller":"traceutil/trace.go:171","msg":"trace[1112762387] transaction","detail":"{read_only:false; response_revision:7833; number_of_response:1; }","duration":"112.516409ms","start":"2026-02-26T17:06:34.068652Z","end":"2026-02-26T17:06:34.181168Z","steps":["trace[1112762387] 'process raft request' (duration: 112.336125ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:06:34.215558Z","caller":"traceutil/trace.go:171","msg":"trace[98178953] transaction","detail":"{read_only:false; response_revision:7834; number_of_response:1; }","duration":"146.691089ms","start":"2026-02-26T17:06:34.068822Z","end":"2026-02-26T17:06:34.215513Z","steps":["trace[98178953] 'process raft request' (duration: 146.520406ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:06:34.215884Z","caller":"traceutil/trace.go:171","msg":"trace[579820804] transaction","detail":"{read_only:false; response_revision:7835; number_of_response:1; }","duration":"147.007135ms","start":"2026-02-26T17:06:34.068825Z","end":"2026-02-26T17:06:34.215832Z","steps":["trace[579820804] 'process raft request' (duration: 146.647538ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:06:34.216106Z","caller":"traceutil/trace.go:171","msg":"trace[291481058] linearizableReadLoop","detail":"{readStateIndex:8129; appliedIndex:8124; }","duration":"145.994815ms","start":"2026-02-26T17:06:34.070091Z","end":"2026-02-26T17:06:34.216086Z","steps":["trace[291481058] 'read index received' (duration: 110.896736ms)","trace[291481058] 'applied index is now lower than readState.Index' (duration: 35.096579ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:06:34.216171Z","caller":"traceutil/trace.go:171","msg":"trace[1840142853] transaction","detail":"{read_only:false; response_revision:7837; number_of_response:1; }","duration":"147.145228ms","start":"2026-02-26T17:06:34.069009Z","end":"2026-02-26T17:06:34.216155Z","steps":["trace[1840142853] 'process raft request' (duration: 146.935924ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:06:34.216219Z","caller":"traceutil/trace.go:171","msg":"trace[816513396] transaction","detail":"{read_only:false; response_revision:7836; number_of_response:1; }","duration":"147.24126ms","start":"2026-02-26T17:06:34.068939Z","end":"2026-02-26T17:06:34.216181Z","steps":["trace[816513396] 'process raft request' (duration: 146.814062ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:06:34.216316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.200149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12211"} {"level":"info","ts":"2026-02-26T17:06:34.216364Z","caller":"traceutil/trace.go:171","msg":"trace[1912033576] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:7839; }","duration":"146.28804ms","start":"2026-02-26T17:06:34.070062Z","end":"2026-02-26T17:06:34.21635Z","steps":["trace[1912033576] 'agreement among raft nodes before linearized reading' (duration: 146.113657ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:06:44.150472Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5753} {"level":"info","ts":"2026-02-26T17:06:44.26078Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5753,"took":"108.434986ms","hash":4063415691,"current-db-size-bytes":42270720,"current-db-size":"42 MB","current-db-size-in-use-bytes":23601152,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-02-26T17:06:44.260908Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4063415691,"revision":5753,"compact-revision":2784} {"level":"info","ts":"2026-02-26T17:07:20.427822Z","caller":"traceutil/trace.go:171","msg":"trace[418819515] linearizableReadLoop","detail":"{readStateIndex:8576; appliedIndex:8575; }","duration":"106.853736ms","start":"2026-02-26T17:07:20.320942Z","end":"2026-02-26T17:07:20.427796Z","steps":["trace[418819515] 'read index received' (duration: 69.84274ms)","trace[418819515] 'applied index is now lower than readState.Index' (duration: 37.009876ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:07:20.427878Z","caller":"traceutil/trace.go:171","msg":"trace[1909037486] transaction","detail":"{read_only:false; response_revision:8269; number_of_response:1; }","duration":"113.507099ms","start":"2026-02-26T17:07:20.314338Z","end":"2026-02-26T17:07:20.427845Z","steps":["trace[1909037486] 'process raft request' (duration: 76.550344ms)","trace[1909037486] 'compare' (duration: 36.759161ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T17:07:20.428102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.134912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-02-26T17:07:20.428146Z","caller":"traceutil/trace.go:171","msg":"trace[1594334032] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:8269; }","duration":"107.215323ms","start":"2026-02-26T17:07:20.32092Z","end":"2026-02-26T17:07:20.428135Z","steps":["trace[1594334032] 'agreement among raft nodes before linearized reading' (duration: 107.010129ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:07:20.428293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.479738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/glance-db-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:07:20.428388Z","caller":"traceutil/trace.go:171","msg":"trace[151270561] range","detail":"{range_begin:/registry/jobs/openstack/glance-db-init; range_end:; response_count:0; response_revision:8270; }","duration":"102.626721ms","start":"2026-02-26T17:07:20.325739Z","end":"2026-02-26T17:07:20.428366Z","steps":["trace[151270561] 'agreement among raft nodes before linearized reading' (duration: 102.473428ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:07:44.773101Z","caller":"traceutil/trace.go:171","msg":"trace[236375574] linearizableReadLoop","detail":"{readStateIndex:8824; appliedIndex:8823; }","duration":"149.969593ms","start":"2026-02-26T17:07:44.623104Z","end":"2026-02-26T17:07:44.773074Z","steps":["trace[236375574] 'read index received' (duration: 149.050665ms)","trace[236375574] 'applied index is now lower than readState.Index' (duration: 918.108µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:07:44.773205Z","caller":"traceutil/trace.go:171","msg":"trace[664211606] transaction","detail":"{read_only:false; response_revision:8512; number_of_response:1; }","duration":"191.664913ms","start":"2026-02-26T17:07:44.581487Z","end":"2026-02-26T17:07:44.773152Z","steps":["trace[664211606] 'process raft request' (duration: 190.736275ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:07:44.77347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.129002ms","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-02-26T17:07:44.77353Z","caller":"traceutil/trace.go:171","msg":"trace[865618721] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8512; }","duration":"106.227443ms","start":"2026-02-26T17:07:44.667291Z","end":"2026-02-26T17:07:44.773518Z","steps":["trace[865618721] 'agreement among raft nodes before linearized reading' (duration: 106.06399ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:07:44.773728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.937737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-02-26T17:07:44.773851Z","caller":"traceutil/trace.go:171","msg":"trace[837242229] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8512; }","duration":"107.10961ms","start":"2026-02-26T17:07:44.666712Z","end":"2026-02-26T17:07:44.773822Z","steps":["trace[837242229] 'agreement among raft nodes before linearized reading' (duration: 106.689802ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:07:44.773891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.77324ms","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-02-26T17:07:44.773749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.09457ms","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-02-26T17:07:44.773938Z","caller":"traceutil/trace.go:171","msg":"trace[1682585416] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8512; }","duration":"150.872681ms","start":"2026-02-26T17:07:44.623053Z","end":"2026-02-26T17:07:44.773926Z","steps":["trace[1682585416] 'agreement among raft nodes before linearized reading' (duration: 150.168807ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:07:44.773959Z","caller":"traceutil/trace.go:171","msg":"trace[1165734730] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8512; }","duration":"115.348954ms","start":"2026-02-26T17:07:44.658591Z","end":"2026-02-26T17:07:44.77394Z","steps":["trace[1165734730] 'agreement among raft nodes before linearized reading' (duration: 114.851665ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:07:44.774152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.650661ms","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-02-26T17:07:44.774235Z","caller":"traceutil/trace.go:171","msg":"trace[1700704111] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8512; }","duration":"121.779764ms","start":"2026-02-26T17:07:44.652428Z","end":"2026-02-26T17:07:44.774208Z","steps":["trace[1700704111] 'agreement among raft nodes before linearized reading' (duration: 120.923947ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:07:44.881466Z","caller":"traceutil/trace.go:171","msg":"trace[2030728250] linearizableReadLoop","detail":"{readStateIndex:8825; appliedIndex:8824; }","duration":"102.615481ms","start":"2026-02-26T17:07:44.778823Z","end":"2026-02-26T17:07:44.881438Z","steps":["trace[2030728250] 'read index received' (duration: 33.624089ms)","trace[2030728250] 'applied index is now lower than readState.Index' (duration: 68.989912ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:07:44.881585Z","caller":"traceutil/trace.go:171","msg":"trace[1537639332] transaction","detail":"{read_only:false; response_revision:8513; number_of_response:1; }","duration":"103.061121ms","start":"2026-02-26T17:07:44.778467Z","end":"2026-02-26T17:07:44.881528Z","steps":["trace[1537639332] 'process raft request' (duration: 33.975567ms)","trace[1537639332] 'compare' (duration: 68.714527ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T17:07:44.882114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.283534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:31 size:291240"} {"level":"info","ts":"2026-02-26T17:07:44.882163Z","caller":"traceutil/trace.go:171","msg":"trace[1923487969] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:31; response_revision:8513; }","duration":"103.487949ms","start":"2026-02-26T17:07:44.778664Z","end":"2026-02-26T17:07:44.882152Z","steps":["trace[1923487969] 'agreement among raft nodes before linearized reading' (duration: 102.905738ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:07:44.918867Z","caller":"traceutil/trace.go:171","msg":"trace[1380018560] transaction","detail":"{read_only:false; response_revision:8514; number_of_response:1; }","duration":"139.128148ms","start":"2026-02-26T17:07:44.779722Z","end":"2026-02-26T17:07:44.91885Z","steps":["trace[1380018560] 'process raft request' (duration: 138.948024ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:07:44.919176Z","caller":"traceutil/trace.go:171","msg":"trace[1883030031] transaction","detail":"{read_only:false; response_revision:8515; number_of_response:1; }","duration":"139.170529ms","start":"2026-02-26T17:07:44.779978Z","end":"2026-02-26T17:07:44.919148Z","steps":["trace[1883030031] 'process raft request' (duration: 138.830741ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:07:44.919386Z","caller":"traceutil/trace.go:171","msg":"trace[1892616366] transaction","detail":"{read_only:false; response_revision:8516; number_of_response:1; }","duration":"139.185809ms","start":"2026-02-26T17:07:44.780187Z","end":"2026-02-26T17:07:44.919373Z","steps":["trace[1892616366] 'process raft request' (duration: 138.877163ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:07:44.92064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.926685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-26T17:07:44.92069Z","caller":"traceutil/trace.go:171","msg":"trace[1779300409] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:8517; }","duration":"131.031007ms","start":"2026-02-26T17:07:44.789648Z","end":"2026-02-26T17:07:44.920679Z","steps":["trace[1779300409] 'agreement among raft nodes before linearized reading' (duration: 130.919915ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:07:44.920631Z","caller":"traceutil/trace.go:171","msg":"trace[2043228356] transaction","detail":"{read_only:false; response_revision:8517; number_of_response:1; }","duration":"138.953534ms","start":"2026-02-26T17:07:44.78166Z","end":"2026-02-26T17:07:44.920613Z","steps":["trace[2043228356] 'process raft request' (duration: 137.660929ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:10:18.315461Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"f3d52791b64f7591","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-02-26T17:10:18.320462Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-02-26T17:10:18.320532Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-02-26T17:11:00.608948Z","caller":"traceutil/trace.go:171","msg":"trace[320600221] transaction","detail":"{read_only:false; response_revision:10110; number_of_response:1; }","duration":"213.822707ms","start":"2026-02-26T17:11:00.395075Z","end":"2026-02-26T17:11:00.608898Z","steps":["trace[320600221] 'process raft request' (duration: 213.563882ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:11:13.600964Z","caller":"traceutil/trace.go:171","msg":"trace[1642404651] transaction","detail":"{read_only:false; response_revision:10174; number_of_response:1; }","duration":"210.116334ms","start":"2026-02-26T17:11:13.390805Z","end":"2026-02-26T17:11:13.600921Z","steps":["trace[1642404651] 'process raft request' (duration: 209.791066ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:11:13.609008Z","caller":"traceutil/trace.go:171","msg":"trace[843628915] transaction","detail":"{read_only:false; response_revision:10175; number_of_response:1; }","duration":"217.306006ms","start":"2026-02-26T17:11:13.391672Z","end":"2026-02-26T17:11:13.608978Z","steps":["trace[843628915] 'process raft request' (duration: 217.092512ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:11:44.156352Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7905} {"level":"info","ts":"2026-02-26T17:11:44.223097Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7905,"took":"64.921857ms","hash":2864801046,"current-db-size-bytes":42270720,"current-db-size":"42 MB","current-db-size-in-use-bytes":28397568,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-02-26T17:11:44.22316Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2864801046,"revision":7905,"compact-revision":5753} {"level":"info","ts":"2026-02-26T17:16:44.16272Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10375} {"level":"info","ts":"2026-02-26T17:16:44.242955Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10375,"took":"77.724218ms","hash":2040908049,"current-db-size-bytes":42270720,"current-db-size":"42 MB","current-db-size-in-use-bytes":24285184,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-02-26T17:16:44.243021Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2040908049,"revision":10375,"compact-revision":7905} {"level":"info","ts":"2026-02-26T17:17:23.106845Z","caller":"traceutil/trace.go:171","msg":"trace[58973698] transaction","detail":"{read_only:false; response_revision:12487; number_of_response:1; }","duration":"144.340025ms","start":"2026-02-26T17:17:22.962486Z","end":"2026-02-26T17:17:23.106826Z","steps":["trace[58973698] 'process raft request' (duration: 144.208822ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:17:23.268358Z","caller":"traceutil/trace.go:171","msg":"trace[794925347] transaction","detail":"{read_only:false; response_revision:12488; number_of_response:1; }","duration":"115.229174ms","start":"2026-02-26T17:17:23.153091Z","end":"2026-02-26T17:17:23.26832Z","steps":["trace[794925347] 'process raft request' (duration: 114.347676ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:17:38.758177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.755413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:17:38.758266Z","caller":"traceutil/trace.go:171","msg":"trace[1373325161] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12581; }","duration":"243.879265ms","start":"2026-02-26T17:17:38.514366Z","end":"2026-02-26T17:17:38.758245Z","steps":["trace[1373325161] 'range keys from in-memory index tree' (duration: 243.681061ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:17:39.273829Z","caller":"traceutil/trace.go:171","msg":"trace[1635922480] transaction","detail":"{read_only:false; response_revision:12582; number_of_response:1; }","duration":"104.497771ms","start":"2026-02-26T17:17:39.169305Z","end":"2026-02-26T17:17:39.273803Z","steps":["trace[1635922480] 'process raft request' (duration: 104.343238ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:17:40.380555Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8471724563007998964,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-26T17:17:40.516263Z","caller":"traceutil/trace.go:171","msg":"trace[805212798] transaction","detail":"{read_only:false; response_revision:12586; number_of_response:1; }","duration":"670.846645ms","start":"2026-02-26T17:17:39.845385Z","end":"2026-02-26T17:17:40.516232Z","steps":["trace[805212798] 'process raft request' (duration: 670.688082ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:17:40.516419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:17:39.845364Z","time spent":"670.984447ms","remote":"127.0.0.1:60052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T17:17:40.85572Z","caller":"traceutil/trace.go:171","msg":"trace[550306848] linearizableReadLoop","detail":"{readStateIndex:13044; appliedIndex:13042; }","duration":"975.392058ms","start":"2026-02-26T17:17:39.8803Z","end":"2026-02-26T17:17:40.855692Z","steps":["trace[550306848] 'read index received' (duration: 635.774787ms)","trace[550306848] 'applied index is now lower than readState.Index' (duration: 339.616221ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:17:40.855824Z","caller":"traceutil/trace.go:171","msg":"trace[895308075] transaction","detail":"{read_only:false; response_revision:12587; number_of_response:1; }","duration":"1.008896455s","start":"2026-02-26T17:17:39.846904Z","end":"2026-02-26T17:17:40.855801Z","steps":["trace[895308075] 'process raft request' (duration: 1.00865259s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:17:40.855891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"975.565911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-02-26T17:17:40.855934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:17:39.84688Z","time spent":"1.008991388s","remote":"127.0.0.1:60052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T17:17:40.855947Z","caller":"traceutil/trace.go:171","msg":"trace[1500274423] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:12587; }","duration":"975.668394ms","start":"2026-02-26T17:17:39.880263Z","end":"2026-02-26T17:17:40.855931Z","steps":["trace[1500274423] 'agreement among raft nodes before linearized reading' (duration: 975.569132ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:17:40.855992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:17:39.880251Z","time spent":"975.728275ms","remote":"127.0.0.1:44160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":31,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "} {"level":"warn","ts":"2026-02-26T17:17:40.856152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"943.206278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"warn","ts":"2026-02-26T17:17:40.856273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"673.477848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-02-26T17:17:40.856314Z","caller":"traceutil/trace.go:171","msg":"trace[1737963282] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:12587; }","duration":"673.53711ms","start":"2026-02-26T17:17:40.182765Z","end":"2026-02-26T17:17:40.856302Z","steps":["trace[1737963282] 'agreement among raft nodes before linearized reading' (duration: 673.430948ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:17:40.856346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:17:40.182755Z","time spent":"673.582321ms","remote":"127.0.0.1:60052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-02-26T17:17:40.8564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"696.801603ms","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-02-26T17:17:40.856402Z","caller":"traceutil/trace.go:171","msg":"trace[2142047188] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:12587; }","duration":"943.28949ms","start":"2026-02-26T17:17:39.912911Z","end":"2026-02-26T17:17:40.8562Z","steps":["trace[2142047188] 'agreement among raft nodes before linearized reading' (duration: 943.022994ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:17:40.856655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:17:39.912901Z","time spent":"943.675647ms","remote":"127.0.0.1:60052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":583,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"info","ts":"2026-02-26T17:17:40.856437Z","caller":"traceutil/trace.go:171","msg":"trace[1073150343] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:12587; }","duration":"696.876853ms","start":"2026-02-26T17:17:40.15955Z","end":"2026-02-26T17:17:40.856427Z","steps":["trace[1073150343] 'agreement among raft nodes before linearized reading' (duration: 696.772831ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:17:40.85644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.436123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:17:40.857126Z","caller":"traceutil/trace.go:171","msg":"trace[702723604] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:12587; }","duration":"392.179948ms","start":"2026-02-26T17:17:40.464931Z","end":"2026-02-26T17:17:40.857111Z","steps":["trace[702723604] 'agreement among raft nodes before linearized reading' (duration: 391.405973ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:17:40.857179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:17:40.464912Z","time spent":"392.250209ms","remote":"127.0.0.1:59922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":29,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"warn","ts":"2026-02-26T17:17:40.856511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.002968ms","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":"warn","ts":"2026-02-26T17:17:40.856739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:17:40.159524Z","time spent":"697.19779ms","remote":"127.0.0.1:60052","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-02-26T17:17:40.857318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.24338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/\" range_end:\"/registry/secrets/openstack0\" ","response":"range_response_count:86 size:929875"} {"level":"info","ts":"2026-02-26T17:17:40.857339Z","caller":"traceutil/trace.go:171","msg":"trace[1488177174] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:12587; }","duration":"571.859294ms","start":"2026-02-26T17:17:40.285458Z","end":"2026-02-26T17:17:40.857317Z","steps":["trace[1488177174] 'agreement among raft nodes before linearized reading' (duration: 571.023337ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:17:40.857405Z","caller":"traceutil/trace.go:171","msg":"trace[655031729] range","detail":"{range_begin:/registry/secrets/openstack/; range_end:/registry/secrets/openstack0; response_count:86; response_revision:12587; }","duration":"721.302391ms","start":"2026-02-26T17:17:40.136061Z","end":"2026-02-26T17:17:40.857363Z","steps":["trace[655031729] 'agreement among raft nodes before linearized reading' (duration: 720.493535ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:17:40.857475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:17:40.136039Z","time spent":"721.420723ms","remote":"127.0.0.1:59870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":86,"response size":929899,"request content":"key:\"/registry/secrets/openstack/\" range_end:\"/registry/secrets/openstack0\" "} {"level":"warn","ts":"2026-02-26T17:17:40.857412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:17:40.285436Z","time spent":"571.951926ms","remote":"127.0.0.1:44194","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"warn","ts":"2026-02-26T17:17:40.856524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.414857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T17:17:40.85651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"683.835834ms","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-02-26T17:17:40.857666Z","caller":"traceutil/trace.go:171","msg":"trace[1409432348] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12587; }","duration":"341.57183ms","start":"2026-02-26T17:17:40.516052Z","end":"2026-02-26T17:17:40.857624Z","steps":["trace[1409432348] 'agreement among raft nodes before linearized reading' (duration: 340.444008ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:17:40.857758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:17:40.516032Z","time spent":"341.697283ms","remote":"127.0.0.1:59796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-26T17:17:40.857736Z","caller":"traceutil/trace.go:171","msg":"trace[1862742068] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:12587; }","duration":"685.078959ms","start":"2026-02-26T17:17:40.172639Z","end":"2026-02-26T17:17:40.857718Z","steps":["trace[1862742068] 'agreement among raft nodes before linearized reading' (duration: 683.816404ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:17:40.857945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:17:40.17263Z","time spent":"685.271602ms","remote":"127.0.0.1:60052","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":"info","ts":"2026-02-26T17:17:41.71382Z","caller":"traceutil/trace.go:171","msg":"trace[1136959408] transaction","detail":"{read_only:false; response_revision:12597; number_of_response:1; }","duration":"142.14195ms","start":"2026-02-26T17:17:41.571637Z","end":"2026-02-26T17:17:41.713779Z","steps":["trace[1136959408] 'process raft request' (duration: 135.63002ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:17:41.832699Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000331d.wal"} {"level":"warn","ts":"2026-02-26T17:18:00.905456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.287283ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-26T17:18:00.905652Z","caller":"traceutil/trace.go:171","msg":"trace[156189844] transaction","detail":"{read_only:false; response_revision:13021; number_of_response:1; }","duration":"162.351362ms","start":"2026-02-26T17:18:00.743274Z","end":"2026-02-26T17:18:00.905625Z","steps":["trace[156189844] 'process raft request' (duration: 21.810443ms)","trace[156189844] 'compare' (duration: 140.12426ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:18:47.648536Z","caller":"traceutil/trace.go:171","msg":"trace[863877544] transaction","detail":"{read_only:false; response_revision:13571; number_of_response:1; }","duration":"314.882888ms","start":"2026-02-26T17:18:47.333601Z","end":"2026-02-26T17:18:47.648484Z","steps":["trace[863877544] 'process raft request' (duration: 265.448435ms)","trace[863877544] 'compare' (duration: 49.004995ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:18:47.648686Z","caller":"traceutil/trace.go:171","msg":"trace[811105641] transaction","detail":"{read_only:false; response_revision:13572; number_of_response:1; }","duration":"143.405356ms","start":"2026-02-26T17:18:47.505245Z","end":"2026-02-26T17:18:47.64865Z","steps":["trace[811105641] 'process raft request' (duration: 143.197621ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:18:47.648725Z","caller":"traceutil/trace.go:171","msg":"trace[1220252914] linearizableReadLoop","detail":"{readStateIndex:14054; appliedIndex:14052; }","duration":"313.923679ms","start":"2026-02-26T17:18:47.33471Z","end":"2026-02-26T17:18:47.648633Z","steps":["trace[1220252914] 'read index received' (duration: 6.783355ms)","trace[1220252914] 'applied index is now lower than readState.Index' (duration: 307.125414ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T17:18:47.648866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:18:47.333577Z","time spent":"315.055462ms","remote":"127.0.0.1:60252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6884,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T17:18:47.64899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.262277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"info","ts":"2026-02-26T17:18:47.649094Z","caller":"traceutil/trace.go:171","msg":"trace[388892644] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:13573; }","duration":"314.3977ms","start":"2026-02-26T17:18:47.334651Z","end":"2026-02-26T17:18:47.649048Z","steps":["trace[388892644] 'agreement among raft nodes before linearized reading' (duration: 314.160265ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:18:47.6491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.229668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:356"} {"level":"warn","ts":"2026-02-26T17:18:47.649129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:18:47.334638Z","time spent":"314.484582ms","remote":"127.0.0.1:60022","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5547,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "} {"level":"info","ts":"2026-02-26T17:18:47.649143Z","caller":"traceutil/trace.go:171","msg":"trace[1999902567] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:13573; }","duration":"296.306249ms","start":"2026-02-26T17:18:47.352824Z","end":"2026-02-26T17:18:47.64913Z","steps":["trace[1999902567] 'agreement among raft nodes before linearized reading' (duration: 296.135905ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:18:47.649262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.694394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:665"} {"level":"warn","ts":"2026-02-26T17:18:47.649331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.885297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:18:47.649339Z","caller":"traceutil/trace.go:171","msg":"trace[340610678] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:13573; }","duration":"121.809416ms","start":"2026-02-26T17:18:47.527508Z","end":"2026-02-26T17:18:47.649318Z","steps":["trace[340610678] 'agreement among raft nodes before linearized reading' (duration: 121.467479ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:18:47.649349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.382617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T17:18:47.649325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.118932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:18:47.649373Z","caller":"traceutil/trace.go:171","msg":"trace[403065642] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:13573; }","duration":"132.961748ms","start":"2026-02-26T17:18:47.516397Z","end":"2026-02-26T17:18:47.649359Z","steps":["trace[403065642] 'agreement among raft nodes before linearized reading' (duration: 132.911127ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:18:47.649393Z","caller":"traceutil/trace.go:171","msg":"trace[1176990152] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:13573; }","duration":"224.444629ms","start":"2026-02-26T17:18:47.42493Z","end":"2026-02-26T17:18:47.649375Z","steps":["trace[1176990152] 'agreement among raft nodes before linearized reading' (duration: 224.391018ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:18:47.649443Z","caller":"traceutil/trace.go:171","msg":"trace[1502304346] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:13573; }","duration":"224.273535ms","start":"2026-02-26T17:18:47.425127Z","end":"2026-02-26T17:18:47.6494Z","steps":["trace[1502304346] 'agreement among raft nodes before linearized reading' (duration: 224.144993ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:18:47.649279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.835788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"warn","ts":"2026-02-26T17:18:47.649791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.49606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"info","ts":"2026-02-26T17:18:47.649839Z","caller":"traceutil/trace.go:171","msg":"trace[511979048] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:13573; }","duration":"120.564211ms","start":"2026-02-26T17:18:47.529264Z","end":"2026-02-26T17:18:47.649828Z","steps":["trace[511979048] 'agreement among raft nodes before linearized reading' (duration: 120.453218ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:18:47.64975Z","caller":"traceutil/trace.go:171","msg":"trace[1067947991] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:13573; }","duration":"219.329358ms","start":"2026-02-26T17:18:47.430408Z","end":"2026-02-26T17:18:47.649737Z","steps":["trace[1067947991] 'agreement among raft nodes before linearized reading' (duration: 218.704086ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:18:47.649693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.170513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T17:18:47.649796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.51246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:18:47.650065Z","caller":"traceutil/trace.go:171","msg":"trace[1466815558] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:13573; }","duration":"122.572571ms","start":"2026-02-26T17:18:47.527475Z","end":"2026-02-26T17:18:47.650048Z","steps":["trace[1466815558] 'agreement among raft nodes before linearized reading' (duration: 121.806966ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:18:47.650091Z","caller":"traceutil/trace.go:171","msg":"trace[1972171772] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:13573; }","duration":"224.868196ms","start":"2026-02-26T17:18:47.425212Z","end":"2026-02-26T17:18:47.65008Z","steps":["trace[1972171772] 'agreement among raft nodes before linearized reading' (duration: 224.55588ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:19:20.75292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.01539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:19:20.753023Z","caller":"traceutil/trace.go:171","msg":"trace[245095881] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:13732; }","duration":"116.170463ms","start":"2026-02-26T17:19:20.636828Z","end":"2026-02-26T17:19:20.752998Z","steps":["trace[245095881] 'range keys from in-memory index tree' (duration: 115.939529ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:19:20.753145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.170493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:19:20.753209Z","caller":"traceutil/trace.go:171","msg":"trace[840060628] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:0; response_revision:13732; }","duration":"116.287575ms","start":"2026-02-26T17:19:20.636907Z","end":"2026-02-26T17:19:20.753195Z","steps":["trace[840060628] 'range keys from in-memory index tree' (duration: 116.089121ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:19:20.7532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.380848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"warn","ts":"2026-02-26T17:19:20.753247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.214208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-89mfc\" ","response":"range_response_count:1 size:9799"} {"level":"info","ts":"2026-02-26T17:19:20.753325Z","caller":"traceutil/trace.go:171","msg":"trace[46247817] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:13732; }","duration":"110.583692ms","start":"2026-02-26T17:19:20.642713Z","end":"2026-02-26T17:19:20.753296Z","steps":["trace[46247817] 'range keys from in-memory index tree' (duration: 110.139613ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:19:20.753354Z","caller":"traceutil/trace.go:171","msg":"trace[558925820] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-89mfc; range_end:; response_count:1; response_revision:13732; }","duration":"294.36179ms","start":"2026-02-26T17:19:20.458971Z","end":"2026-02-26T17:19:20.753332Z","steps":["trace[558925820] 'range keys from in-memory index tree' (duration: 294.039894ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:19:20.75334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.195933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-metadata\" ","response":"range_response_count:1 size:681"} {"level":"warn","ts":"2026-02-26T17:19:20.753378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.381409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-6bppt\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-02-26T17:19:20.753431Z","caller":"traceutil/trace.go:171","msg":"trace[1809481089] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-metadata; range_end:; response_count:1; response_revision:13732; }","duration":"116.363196ms","start":"2026-02-26T17:19:20.637047Z","end":"2026-02-26T17:19:20.753411Z","steps":["trace[1809481089] 'range keys from in-memory index tree' (duration: 115.922258ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:19:20.75344Z","caller":"traceutil/trace.go:171","msg":"trace[1827939270] range","detail":"{range_begin:/registry/pods/openstack/keepalived-6bppt; range_end:; response_count:1; response_revision:13732; }","duration":"193.484012ms","start":"2026-02-26T17:19:20.559938Z","end":"2026-02-26T17:19:20.753422Z","steps":["trace[1827939270] 'range keys from in-memory index tree' (duration: 193.246117ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:19:20.753473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.159333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:19:20.7535Z","caller":"traceutil/trace.go:171","msg":"trace[797787286] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:13732; }","duration":"236.218554ms","start":"2026-02-26T17:19:20.517275Z","end":"2026-02-26T17:19:20.753493Z","steps":["trace[797787286] 'range keys from in-memory index tree' (duration: 236.079579ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:19:20.753596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.396748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:665"} {"level":"info","ts":"2026-02-26T17:19:20.753679Z","caller":"traceutil/trace.go:171","msg":"trace[145353320] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:13732; }","duration":"110.51347ms","start":"2026-02-26T17:19:20.64314Z","end":"2026-02-26T17:19:20.753654Z","steps":["trace[145353320] 'range keys from in-memory index tree' (duration: 109.733955ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:19:21.168247Z","caller":"traceutil/trace.go:171","msg":"trace[634966371] transaction","detail":"{read_only:false; response_revision:13733; number_of_response:1; }","duration":"118.691703ms","start":"2026-02-26T17:19:21.049523Z","end":"2026-02-26T17:19:21.168215Z","steps":["trace[634966371] 'process raft request' (duration: 118.421458ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:19:21.592702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.398721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T17:19:21.59283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.489703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:19:21.592814Z","caller":"traceutil/trace.go:171","msg":"trace[2054605623] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:13733; }","duration":"188.547154ms","start":"2026-02-26T17:19:21.404241Z","end":"2026-02-26T17:19:21.592788Z","steps":["trace[2054605623] 'range keys from in-memory index tree' (duration: 188.342ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:19:21.592917Z","caller":"traceutil/trace.go:171","msg":"trace[720632493] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:13733; }","duration":"187.598905ms","start":"2026-02-26T17:19:21.405299Z","end":"2026-02-26T17:19:21.592898Z","steps":["trace[720632493] 'range keys from in-memory index tree' (duration: 187.447342ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:19:21.593042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.733858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T17:19:21.593108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.504168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-02-26T17:19:21.593087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.708215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-02-26T17:19:21.593177Z","caller":"traceutil/trace.go:171","msg":"trace[330477543] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:13733; }","duration":"135.59192ms","start":"2026-02-26T17:19:21.457569Z","end":"2026-02-26T17:19:21.593161Z","steps":["trace[330477543] 'range keys from in-memory index tree' (duration: 135.291473ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:19:21.593131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.719332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:19:21.593252Z","caller":"traceutil/trace.go:171","msg":"trace[619413498] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:13733; }","duration":"208.90676ms","start":"2026-02-26T17:19:21.38431Z","end":"2026-02-26T17:19:21.593217Z","steps":["trace[619413498] 'range keys from in-memory index tree' (duration: 208.49133ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:19:21.593263Z","caller":"traceutil/trace.go:171","msg":"trace[344492597] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:13733; }","duration":"140.848105ms","start":"2026-02-26T17:19:21.452363Z","end":"2026-02-26T17:19:21.593211Z","steps":["trace[344492597] 'count revisions from in-memory index tree' (duration: 140.61826ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:19:21.593151Z","caller":"traceutil/trace.go:171","msg":"trace[1563802723] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:13733; }","duration":"187.881811ms","start":"2026-02-26T17:19:21.405239Z","end":"2026-02-26T17:19:21.593121Z","steps":["trace[1563802723] 'range keys from in-memory index tree' (duration: 187.602755ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:19:21.593877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.848797ms","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-02-26T17:19:21.59401Z","caller":"traceutil/trace.go:171","msg":"trace[2091837461] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:13733; }","duration":"214.921309ms","start":"2026-02-26T17:19:21.379058Z","end":"2026-02-26T17:19:21.593979Z","steps":["trace[2091837461] 'range keys from in-memory index tree' (duration: 213.621163ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:19:21.594876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.375966ms","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-02-26T17:19:21.595056Z","caller":"traceutil/trace.go:171","msg":"trace[1465250808] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:13733; }","duration":"233.56409ms","start":"2026-02-26T17:19:21.361437Z","end":"2026-02-26T17:19:21.595001Z","steps":["trace[1465250808] 'range keys from in-memory index tree' (duration: 233.082071ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:21:44.169182Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12260} {"level":"info","ts":"2026-02-26T17:21:44.246163Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12260,"took":"73.992202ms","hash":2458542650,"current-db-size-bytes":42270720,"current-db-size":"42 MB","current-db-size-in-use-bytes":29204480,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-02-26T17:21:44.246217Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2458542650,"revision":12260,"compact-revision":10375} {"level":"info","ts":"2026-02-26T17:25:11.458903Z","caller":"traceutil/trace.go:171","msg":"trace[1549034813] transaction","detail":"{read_only:false; response_revision:15943; number_of_response:1; }","duration":"532.639913ms","start":"2026-02-26T17:25:10.926232Z","end":"2026-02-26T17:25:11.458872Z","steps":["trace[1549034813] 'process raft request' (duration: 532.359928ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:25:11.459124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:25:10.926196Z","time spent":"532.807947ms","remote":"127.0.0.1:60052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T17:25:11.617596Z","caller":"traceutil/trace.go:171","msg":"trace[696494869] transaction","detail":"{read_only:false; response_revision:15944; number_of_response:1; }","duration":"653.738315ms","start":"2026-02-26T17:25:10.96382Z","end":"2026-02-26T17:25:11.617559Z","steps":["trace[696494869] 'process raft request' (duration: 587.374705ms)","trace[696494869] 'compare' (duration: 66.197737ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:25:11.617654Z","caller":"traceutil/trace.go:171","msg":"trace[894625901] linearizableReadLoop","detail":"{readStateIndex:16518; appliedIndex:16516; }","duration":"578.219301ms","start":"2026-02-26T17:25:11.039394Z","end":"2026-02-26T17:25:11.617614Z","steps":["trace[894625901] 'read index received' (duration: 419.253487ms)","trace[894625901] 'applied index is now lower than readState.Index' (duration: 158.959684ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T17:25:11.617737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:25:10.963797Z","time spent":"653.866997ms","remote":"127.0.0.1:60052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T17:25:11.617874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.385765ms","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-02-26T17:25:11.61786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.446165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-26T17:25:11.617944Z","caller":"traceutil/trace.go:171","msg":"trace[1493503716] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15945; }","duration":"578.601319ms","start":"2026-02-26T17:25:11.039324Z","end":"2026-02-26T17:25:11.617925Z","steps":["trace[1493503716] 'agreement among raft nodes before linearized reading' (duration: 578.378315ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:25:11.617984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:25:11.039297Z","time spent":"578.67914ms","remote":"127.0.0.1:60052","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-02-26T17:25:11.618026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.970397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-02-26T17:25:11.618083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.882989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:25:11.618106Z","caller":"traceutil/trace.go:171","msg":"trace[1019216594] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15945; }","duration":"101.9438ms","start":"2026-02-26T17:25:11.516156Z","end":"2026-02-26T17:25:11.618099Z","steps":["trace[1019216594] 'agreement among raft nodes before linearized reading' (duration: 101.90823ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:25:11.618116Z","caller":"traceutil/trace.go:171","msg":"trace[692717385] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:15945; }","duration":"336.086011ms","start":"2026-02-26T17:25:11.281999Z","end":"2026-02-26T17:25:11.618084Z","steps":["trace[692717385] 'agreement among raft nodes before linearized reading' (duration: 335.902507ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:25:11.618165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:25:11.281983Z","time spent":"336.171523ms","remote":"127.0.0.1:59942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":13,"response size":31,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "} {"level":"info","ts":"2026-02-26T17:25:11.617906Z","caller":"traceutil/trace.go:171","msg":"trace[466877149] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:15945; }","duration":"244.437057ms","start":"2026-02-26T17:25:11.37346Z","end":"2026-02-26T17:25:11.617897Z","steps":["trace[466877149] 'agreement among raft nodes before linearized reading' (duration: 244.373545ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:25:11.618161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.577195ms","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-02-26T17:25:11.618264Z","caller":"traceutil/trace.go:171","msg":"trace[1429269457] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:15945; }","duration":"305.687226ms","start":"2026-02-26T17:25:11.31256Z","end":"2026-02-26T17:25:11.618247Z","steps":["trace[1429269457] 'agreement among raft nodes before linearized reading' (duration: 305.42772ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:25:11.618302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:25:11.312551Z","time spent":"305.742667ms","remote":"127.0.0.1:60052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-26T17:25:11.618383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.533579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-02-26T17:25:11.618413Z","caller":"traceutil/trace.go:171","msg":"trace[1573079731] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:15945; }","duration":"456.61218ms","start":"2026-02-26T17:25:11.161792Z","end":"2026-02-26T17:25:11.618404Z","steps":["trace[1573079731] 'agreement among raft nodes before linearized reading' (duration: 456.536399ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:25:11.618436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:25:11.16177Z","time spent":"456.660132ms","remote":"127.0.0.1:60052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":583,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-02-26T17:25:11.618428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.242543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" ","response":"range_response_count:1 size:1857"} {"level":"warn","ts":"2026-02-26T17:25:11.618535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.183875ms","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-02-26T17:25:11.618598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.875971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-02-26T17:25:11.618629Z","caller":"traceutil/trace.go:171","msg":"trace[261658583] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:15945; }","duration":"294.926353ms","start":"2026-02-26T17:25:11.323693Z","end":"2026-02-26T17:25:11.61862Z","steps":["trace[261658583] 'agreement among raft nodes before linearized reading' (duration: 294.391272ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:25:11.618539Z","caller":"traceutil/trace.go:171","msg":"trace[890372205] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0; range_end:; response_count:1; response_revision:15945; }","duration":"359.467197ms","start":"2026-02-26T17:25:11.259045Z","end":"2026-02-26T17:25:11.618512Z","steps":["trace[890372205] 'agreement among raft nodes before linearized reading' (duration: 359.099199ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:25:11.618665Z","caller":"traceutil/trace.go:171","msg":"trace[1144001856] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:15945; }","duration":"314.336008ms","start":"2026-02-26T17:25:11.304313Z","end":"2026-02-26T17:25:11.618649Z","steps":["trace[1144001856] 'agreement among raft nodes before linearized reading' (duration: 314.078393ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:25:11.618778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:25:11.30429Z","time spent":"314.472891ms","remote":"127.0.0.1:60052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-26T17:25:11.618541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.209202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1986"} {"level":"warn","ts":"2026-02-26T17:25:11.618821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:25:11.259016Z","time spent":"359.747012ms","remote":"127.0.0.1:59942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":1,"response size":1881,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" "} {"level":"info","ts":"2026-02-26T17:25:11.618871Z","caller":"traceutil/trace.go:171","msg":"trace[1226787566] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:15945; }","duration":"462.204752ms","start":"2026-02-26T17:25:11.156656Z","end":"2026-02-26T17:25:11.61886Z","steps":["trace[1226787566] 'agreement among raft nodes before linearized reading' (duration: 461.170581ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:25:11.618916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:25:11.156631Z","time spent":"462.265293ms","remote":"127.0.0.1:59978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":2010,"request content":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" "} {"level":"warn","ts":"2026-02-26T17:25:11.61917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.308424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-mm2rf\" ","response":"range_response_count:1 size:22125"} {"level":"info","ts":"2026-02-26T17:25:11.619249Z","caller":"traceutil/trace.go:171","msg":"trace[1931952928] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-mm2rf; range_end:; response_count:1; response_revision:15945; }","duration":"356.448876ms","start":"2026-02-26T17:25:11.26278Z","end":"2026-02-26T17:25:11.619228Z","steps":["trace[1931952928] 'agreement among raft nodes before linearized reading' (duration: 356.224041ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:25:11.6193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T17:25:11.262753Z","time spent":"356.535968ms","remote":"127.0.0.1:59974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22149,"request content":"key:\"/registry/pods/openstack/nova-compute-default-mm2rf\" "} {"level":"info","ts":"2026-02-26T17:25:19.918268Z","caller":"traceutil/trace.go:171","msg":"trace[1857138785] transaction","detail":"{read_only:false; response_revision:16045; number_of_response:1; }","duration":"122.717102ms","start":"2026-02-26T17:25:19.795516Z","end":"2026-02-26T17:25:19.918233Z","steps":["trace[1857138785] 'process raft request' (duration: 122.493738ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:25:19.918405Z","caller":"traceutil/trace.go:171","msg":"trace[836519247] transaction","detail":"{read_only:false; response_revision:16047; number_of_response:1; }","duration":"122.174471ms","start":"2026-02-26T17:25:19.796219Z","end":"2026-02-26T17:25:19.918393Z","steps":["trace[836519247] 'process raft request' (duration: 121.977647ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:25:19.918506Z","caller":"traceutil/trace.go:171","msg":"trace[1054924823] linearizableReadLoop","detail":"{readStateIndex:16627; appliedIndex:16623; }","duration":"119.694542ms","start":"2026-02-26T17:25:19.798789Z","end":"2026-02-26T17:25:19.918484Z","steps":["trace[1054924823] 'read index received' (duration: 45.190629ms)","trace[1054924823] 'applied index is now lower than readState.Index' (duration: 74.502823ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T17:25:19.91828Z","caller":"traceutil/trace.go:171","msg":"trace[38314285] transaction","detail":"{read_only:false; response_revision:16046; number_of_response:1; }","duration":"122.466817ms","start":"2026-02-26T17:25:19.795789Z","end":"2026-02-26T17:25:19.918256Z","steps":["trace[38314285] 'process raft request' (duration: 122.354695ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:25:19.918727Z","caller":"traceutil/trace.go:171","msg":"trace[805709153] transaction","detail":"{read_only:false; response_revision:16048; number_of_response:1; }","duration":"116.593901ms","start":"2026-02-26T17:25:19.802121Z","end":"2026-02-26T17:25:19.918715Z","steps":["trace[805709153] 'process raft request' (duration: 116.239584ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:25:19.918965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.406627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/libvirt-libvirt-default-v56vz-vnc\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T17:25:19.919016Z","caller":"traceutil/trace.go:171","msg":"trace[2124776564] range","detail":"{range_begin:/registry/secrets/openstack/libvirt-libvirt-default-v56vz-vnc; range_end:; response_count:0; response_revision:16048; }","duration":"119.483529ms","start":"2026-02-26T17:25:19.79952Z","end":"2026-02-26T17:25:19.919004Z","steps":["trace[2124776564] 'agreement among raft nodes before linearized reading' (duration: 119.397447ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:25:19.919397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.575331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-02-26T17:25:19.919435Z","caller":"traceutil/trace.go:171","msg":"trace[392359371] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:16048; }","duration":"115.627771ms","start":"2026-02-26T17:25:19.803798Z","end":"2026-02-26T17:25:19.919426Z","steps":["trace[392359371] 'agreement among raft nodes before linearized reading' (duration: 115.477718ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:25:19.919515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.709483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:90 size:891329"} {"level":"info","ts":"2026-02-26T17:25:19.919547Z","caller":"traceutil/trace.go:171","msg":"trace[628970347] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:90; response_revision:16048; }","duration":"120.768724ms","start":"2026-02-26T17:25:19.798771Z","end":"2026-02-26T17:25:19.91954Z","steps":["trace[628970347] 'agreement among raft nodes before linearized reading' (duration: 120.08427ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T17:25:19.920541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.612892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2209360"} {"level":"info","ts":"2026-02-26T17:25:19.920681Z","caller":"traceutil/trace.go:171","msg":"trace[798540497] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:16048; }","duration":"109.774696ms","start":"2026-02-26T17:25:19.810887Z","end":"2026-02-26T17:25:19.920662Z","steps":["trace[798540497] 'agreement among raft nodes before linearized reading' (duration: 108.273606ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T17:26:44.175862Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14732} {"level":"info","ts":"2026-02-26T17:26:44.275945Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14732,"took":"96.353844ms","hash":2816847519,"current-db-size-bytes":42270720,"current-db-size":"42 MB","current-db-size-in-use-bytes":24465408,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-02-26T17:26:44.276018Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2816847519,"revision":14732,"compact-revision":12260}