{"level":"warn","ts":"2026-06-24T10:58:22.707143Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-24T10:58:22.707241Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.191:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.191:2380","--initial-cluster=instance=https://199.19.213.191:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.191:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.191: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-06-24T10:58:22.707311Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-24T10:58:22.707326Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.191:2380"]} {"level":"info","ts":"2026-06-24T10:58:22.707345Z","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-06-24T10:58:22.707973Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.191:2379"]} {"level":"info","ts":"2026-06-24T10:58:22.70805Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.191:2380"],"listen-peer-urls":["https://199.19.213.191:2380"],"advertise-client-urls":["https://199.19.213.191:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.191:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.191: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-06-24T10:58:22.711572Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.289474ms"} {"level":"info","ts":"2026-06-24T10:58:22.717068Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e892d50a3a4fc0f4","cluster-id":"21eccdda20ff4e92"} {"level":"info","ts":"2026-06-24T10:58:22.717129Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 switched to configuration voters=()"} {"level":"info","ts":"2026-06-24T10:58:22.717155Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 became follower at term 0"} {"level":"info","ts":"2026-06-24T10:58:22.717172Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e892d50a3a4fc0f4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-24T10:58:22.717188Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 became follower at term 1"} {"level":"info","ts":"2026-06-24T10:58:22.717228Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 switched to configuration voters=(16758691403303731444)"} {"level":"warn","ts":"2026-06-24T10:58:22.728862Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-24T10:58:22.731222Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-24T10:58:22.732848Z","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-06-24T10:58:22.7363Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e892d50a3a4fc0f4","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-24T10:58:22.736466Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e892d50a3a4fc0f4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-24T10:58:22.736604Z","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-06-24T10:58:22.736763Z","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-06-24T10:58:22.736842Z","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-06-24T10:58:22.737661Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 switched to configuration voters=(16758691403303731444)"} {"level":"info","ts":"2026-06-24T10:58:22.738686Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"21eccdda20ff4e92","local-member-id":"e892d50a3a4fc0f4","added-peer-id":"e892d50a3a4fc0f4","added-peer-peer-urls":["https://199.19.213.191:2380"]} {"level":"info","ts":"2026-06-24T10:58:22.742483Z","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-06-24T10:58:22.742651Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.191:2380"} {"level":"info","ts":"2026-06-24T10:58:22.742688Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.191:2380"} {"level":"info","ts":"2026-06-24T10:58:22.742917Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e892d50a3a4fc0f4","initial-advertise-peer-urls":["https://199.19.213.191:2380"],"listen-peer-urls":["https://199.19.213.191:2380"],"advertise-client-urls":["https://199.19.213.191:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.191:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-24T10:58:22.742977Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-24T10:58:23.617811Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 is starting a new election at term 1"} {"level":"info","ts":"2026-06-24T10:58:23.617915Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-24T10:58:23.617955Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 received MsgPreVoteResp from e892d50a3a4fc0f4 at term 1"} {"level":"info","ts":"2026-06-24T10:58:23.617977Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 became candidate at term 2"} {"level":"info","ts":"2026-06-24T10:58:23.617995Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 received MsgVoteResp from e892d50a3a4fc0f4 at term 2"} {"level":"info","ts":"2026-06-24T10:58:23.618011Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e892d50a3a4fc0f4 became leader at term 2"} {"level":"info","ts":"2026-06-24T10:58:23.61803Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e892d50a3a4fc0f4 elected leader e892d50a3a4fc0f4 at term 2"} {"level":"info","ts":"2026-06-24T10:58:23.619046Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T10:58:23.619933Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e892d50a3a4fc0f4","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.191:2379]}","request-path":"/0/members/e892d50a3a4fc0f4/attributes","cluster-id":"21eccdda20ff4e92","publish-timeout":"7s"} {"level":"info","ts":"2026-06-24T10:58:23.62002Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-24T10:58:23.620109Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-24T10:58:23.623377Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"21eccdda20ff4e92","local-member-id":"e892d50a3a4fc0f4","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T10:58:23.623536Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T10:58:23.623568Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T10:58:23.624892Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-24T10:58:23.626813Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.191:2379"} {"level":"info","ts":"2026-06-24T10:58:23.62727Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-24T10:58:23.627323Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-24T10:59:10.437921Z","caller":"traceutil/trace.go:171","msg":"trace[1952920009] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"186.702642ms","start":"2026-06-24T10:59:10.251149Z","end":"2026-06-24T10:59:10.437851Z","steps":["trace[1952920009] 'process raft request' (duration: 186.363086ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:59:10.72757Z","caller":"traceutil/trace.go:171","msg":"trace[883276113] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"325.262618ms","start":"2026-06-24T10:59:10.402254Z","end":"2026-06-24T10:59:10.727517Z","steps":["trace[883276113] 'process raft request' (duration: 323.275019ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:59:10.727789Z","caller":"traceutil/trace.go:171","msg":"trace[831072689] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:625; }","duration":"266.076206ms","start":"2026-06-24T10:59:10.461606Z","end":"2026-06-24T10:59:10.727683Z","steps":["trace[831072689] 'read index received' (duration: 258.515638ms)","trace[831072689] 'applied index is now lower than readState.Index' (duration: 7.557138ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T10:59:10.727849Z","caller":"traceutil/trace.go:171","msg":"trace[44887064] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"285.81984ms","start":"2026-06-24T10:59:10.441995Z","end":"2026-06-24T10:59:10.727815Z","steps":["trace[44887064] 'process raft request' (duration: 285.448763ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:59:10.727973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.351402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-24T10:59:10.728057Z","caller":"traceutil/trace.go:171","msg":"trace[888640870] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:601; }","duration":"266.474434ms","start":"2026-06-24T10:59:10.461567Z","end":"2026-06-24T10:59:10.728041Z","steps":["trace[888640870] 'agreement among raft nodes before linearized reading' (duration: 266.312131ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:59:10.728408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:59:10.402208Z","time spent":"325.468891ms","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T10:59:11.204943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.124665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T10:59:11.205036Z","caller":"traceutil/trace.go:171","msg":"trace[571839212] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:603; }","duration":"149.261249ms","start":"2026-06-24T10:59:11.055752Z","end":"2026-06-24T10:59:11.205013Z","steps":["trace[571839212] 'range keys from in-memory index tree' (duration: 148.982832ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:59:11.302762Z","caller":"traceutil/trace.go:171","msg":"trace[1597273321] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"110.96755ms","start":"2026-06-24T10:59:11.19176Z","end":"2026-06-24T10:59:11.302728Z","steps":["trace[1597273321] 'process raft request' (duration: 110.384799ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:59:26.837935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.074641ms","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-06-24T10:59:26.838622Z","caller":"traceutil/trace.go:171","msg":"trace[1470295190] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:764; }","duration":"224.794408ms","start":"2026-06-24T10:59:26.613816Z","end":"2026-06-24T10:59:26.83861Z","steps":["trace[1470295190] 'range keys from in-memory index tree' (duration: 223.911947ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:59:26.838048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.974615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.191\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-24T10:59:26.838729Z","caller":"traceutil/trace.go:171","msg":"trace[21502995] range","detail":"{range_begin:/registry/masterleases/199.19.213.191; range_end:; response_count:1; response_revision:764; }","duration":"267.712502ms","start":"2026-06-24T10:59:26.570999Z","end":"2026-06-24T10:59:26.838711Z","steps":["trace[21502995] 'range keys from in-memory index tree' (duration: 266.813761ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:59:58.387808Z","caller":"traceutil/trace.go:171","msg":"trace[1470509423] transaction","detail":"{read_only:false; response_revision:1169; number_of_response:1; }","duration":"188.65775ms","start":"2026-06-24T10:59:58.199114Z","end":"2026-06-24T10:59:58.387772Z","steps":["trace[1470509423] 'process raft request' (duration: 188.465054ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:39.063831Z","caller":"traceutil/trace.go:171","msg":"trace[401884702] transaction","detail":"{read_only:false; response_revision:1728; number_of_response:1; }","duration":"101.65467ms","start":"2026-06-24T11:00:38.962132Z","end":"2026-06-24T11:00:39.063787Z","steps":["trace[401884702] 'process raft request' (duration: 27.240786ms)","trace[401884702] 'compare' (duration: 74.28931ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:00:47.684183Z","caller":"traceutil/trace.go:171","msg":"trace[1112021934] transaction","detail":"{read_only:false; response_revision:1840; number_of_response:1; }","duration":"321.38688ms","start":"2026-06-24T11:00:47.362769Z","end":"2026-06-24T11:00:47.684156Z","steps":["trace[1112021934] 'process raft request' (duration: 321.171933ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:47.684507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:47.362738Z","time spent":"321.639349ms","remote":"127.0.0.1:56968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T11:00:47.915185Z","caller":"traceutil/trace.go:171","msg":"trace[1525824503] linearizableReadLoop","detail":"{readStateIndex:1916; appliedIndex:1914; }","duration":"541.023049ms","start":"2026-06-24T11:00:47.37413Z","end":"2026-06-24T11:00:47.915153Z","steps":["trace[1525824503] 'read index received' (duration: 309.832055ms)","trace[1525824503] 'applied index is now lower than readState.Index' (duration: 231.189834ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:00:47.915485Z","caller":"traceutil/trace.go:171","msg":"trace[1965383043] transaction","detail":"{read_only:false; response_revision:1841; number_of_response:1; }","duration":"552.080978ms","start":"2026-06-24T11:00:47.363392Z","end":"2026-06-24T11:00:47.915473Z","steps":["trace[1965383043] 'process raft request' (duration: 463.710892ms)","trace[1965383043] 'compare' (duration: 87.838588ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:00:47.9156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:47.363381Z","time spent":"552.134401ms","remote":"127.0.0.1:56968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T11:00:47.915758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.306703ms","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-06-24T11:00:47.915755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.476126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0345529d-ce30-4edf-9337-57b49876737a\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-24T11:00:47.91585Z","caller":"traceutil/trace.go:171","msg":"trace[1440013018] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1841; }","duration":"244.462738ms","start":"2026-06-24T11:00:47.671365Z","end":"2026-06-24T11:00:47.915828Z","steps":["trace[1440013018] 'agreement among raft nodes before linearized reading' (duration: 244.189459ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:47.91589Z","caller":"traceutil/trace.go:171","msg":"trace[1631179532] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0345529d-ce30-4edf-9337-57b49876737a; range_end:; response_count:1; response_revision:1841; }","duration":"534.655232ms","start":"2026-06-24T11:00:47.381197Z","end":"2026-06-24T11:00:47.915852Z","steps":["trace[1631179532] 'agreement among raft nodes before linearized reading' (duration: 534.28822ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:47.915955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:47.381184Z","time spent":"534.758835ms","remote":"127.0.0.1:56882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0345529d-ce30-4edf-9337-57b49876737a\" "} {"level":"warn","ts":"2026-06-24T11:00:47.916047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.966826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18bbff5adfacc978\" ","response":"range_response_count:1 size:982"} {"level":"info","ts":"2026-06-24T11:00:47.916123Z","caller":"traceutil/trace.go:171","msg":"trace[1374996061] range","detail":"{range_begin:/registry/events/openstack/datadir-percona-xtradb-pxc-0.18bbff5adfacc978; range_end:; response_count:1; response_revision:1841; }","duration":"458.05464ms","start":"2026-06-24T11:00:47.458023Z","end":"2026-06-24T11:00:47.916078Z","steps":["trace[1374996061] 'agreement among raft nodes before linearized reading' (duration: 457.911375ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:47.916155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:47.458Z","time spent":"458.148902ms","remote":"127.0.0.1:56804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":1005,"request content":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18bbff5adfacc978\" "} {"level":"warn","ts":"2026-06-24T11:00:47.916124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.91659ms","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-06-24T11:00:47.916244Z","caller":"traceutil/trace.go:171","msg":"trace[2140137299] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1841; }","duration":"542.146657ms","start":"2026-06-24T11:00:47.374076Z","end":"2026-06-24T11:00:47.916223Z","steps":["trace[2140137299] 'agreement among raft nodes before linearized reading' (duration: 541.780695ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:47.916305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:47.374053Z","time spent":"542.240751ms","remote":"127.0.0.1:56968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-24T11:00:48.278881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.330772ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T11:00:48.279104Z","caller":"traceutil/trace.go:171","msg":"trace[1118390000] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"205.689865ms","start":"2026-06-24T11:00:48.073393Z","end":"2026-06-24T11:00:48.279083Z","steps":["trace[1118390000] 'process raft request' (duration: 205.617643ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:48.279091Z","caller":"traceutil/trace.go:171","msg":"trace[1497576769] transaction","detail":"{read_only:false; response_revision:1845; number_of_response:1; }","duration":"276.592636ms","start":"2026-06-24T11:00:48.002447Z","end":"2026-06-24T11:00:48.27904Z","steps":["trace[1497576769] 'process raft request' (duration: 42.840229ms)","trace[1497576769] 'compare' (duration: 233.140655ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:00:48.279209Z","caller":"traceutil/trace.go:171","msg":"trace[1016237314] linearizableReadLoop","detail":"{readStateIndex:1920; appliedIndex:1919; }","duration":"223.595958ms","start":"2026-06-24T11:00:48.055579Z","end":"2026-06-24T11:00:48.279175Z","steps":["trace[1016237314] 'read index received' (duration: 59.012µs)","trace[1016237314] 'applied index is now lower than readState.Index' (duration: 223.533156ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:00:48.279586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.985002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T11:00:48.279632Z","caller":"traceutil/trace.go:171","msg":"trace[429702070] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1846; }","duration":"224.099025ms","start":"2026-06-24T11:00:48.055522Z","end":"2026-06-24T11:00:48.279621Z","steps":["trace[429702070] 'agreement among raft nodes before linearized reading' (duration: 223.775464ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:39.864058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.555254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T11:01:39.864139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.413037ms","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-06-24T11:01:39.864236Z","caller":"traceutil/trace.go:171","msg":"trace[1053023541] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:2173; }","duration":"186.816603ms","start":"2026-06-24T11:01:39.67739Z","end":"2026-06-24T11:01:39.864207Z","steps":["trace[1053023541] 'count revisions from in-memory index tree' (duration: 186.395158ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:39.864251Z","caller":"traceutil/trace.go:171","msg":"trace[174671224] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2173; }","duration":"103.635165ms","start":"2026-06-24T11:01:39.760586Z","end":"2026-06-24T11:01:39.864222Z","steps":["trace[174671224] 'range keys from in-memory index tree' (duration: 103.114326ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:02:30.595093Z","caller":"traceutil/trace.go:171","msg":"trace[352648906] transaction","detail":"{read_only:false; response_revision:2543; number_of_response:1; }","duration":"168.288184ms","start":"2026-06-24T11:02:30.426789Z","end":"2026-06-24T11:02:30.595077Z","steps":["trace[352648906] 'process raft request' (duration: 167.892419ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:02:41.758401Z","caller":"traceutil/trace.go:171","msg":"trace[498303403] transaction","detail":"{read_only:false; response_revision:2614; number_of_response:1; }","duration":"108.760023ms","start":"2026-06-24T11:02:41.649583Z","end":"2026-06-24T11:02:41.758343Z","steps":["trace[498303403] 'process raft request' (duration: 108.620025ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:02:57.022832Z","caller":"traceutil/trace.go:171","msg":"trace[1695239032] transaction","detail":"{read_only:false; response_revision:2693; number_of_response:1; }","duration":"141.935987ms","start":"2026-06-24T11:02:56.880874Z","end":"2026-06-24T11:02:57.02281Z","steps":["trace[1695239032] 'process raft request' (duration: 72.612011ms)","trace[1695239032] 'compare' (duration: 69.152787ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:02:57.023007Z","caller":"traceutil/trace.go:171","msg":"trace[251851047] transaction","detail":"{read_only:false; response_revision:2694; number_of_response:1; }","duration":"138.630776ms","start":"2026-06-24T11:02:56.884367Z","end":"2026-06-24T11:02:57.022998Z","steps":["trace[251851047] 'process raft request' (duration: 138.407527ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:03:08.128555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.272301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"} {"level":"info","ts":"2026-06-24T11:03:08.128687Z","caller":"traceutil/trace.go:171","msg":"trace[1600443793] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2752; }","duration":"143.478461ms","start":"2026-06-24T11:03:07.985178Z","end":"2026-06-24T11:03:08.128656Z","steps":["trace[1600443793] 'range keys from in-memory index tree' (duration: 142.995062ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:07:11.68081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.279402ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T11:07:11.681577Z","caller":"traceutil/trace.go:171","msg":"trace[567165762] transaction","detail":"{read_only:false; response_revision:4431; number_of_response:1; }","duration":"121.73289ms","start":"2026-06-24T11:07:11.559791Z","end":"2026-06-24T11:07:11.681524Z","steps":["trace[567165762] 'process raft request' (duration: 121.345799ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:07:11.681814Z","caller":"traceutil/trace.go:171","msg":"trace[109144503] transaction","detail":"{read_only:false; response_revision:4430; number_of_response:1; }","duration":"125.901125ms","start":"2026-06-24T11:07:11.555891Z","end":"2026-06-24T11:07:11.681792Z","steps":["trace[109144503] 'process raft request' (duration: 125.183505ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:07:11.681978Z","caller":"traceutil/trace.go:171","msg":"trace[1263178778] transaction","detail":"{read_only:false; response_revision:4428; number_of_response:1; }","duration":"128.443824ms","start":"2026-06-24T11:07:11.553522Z","end":"2026-06-24T11:07:11.681966Z","steps":["trace[1263178778] 'process raft request' (duration: 15.895898ms)","trace[1263178778] 'compare' (duration: 110.819019ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:07:11.682075Z","caller":"traceutil/trace.go:171","msg":"trace[1766969237] transaction","detail":"{read_only:false; response_revision:4429; number_of_response:1; }","duration":"126.661466ms","start":"2026-06-24T11:07:11.555389Z","end":"2026-06-24T11:07:11.68205Z","steps":["trace[1766969237] 'process raft request' (duration: 125.607547ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:07:11.882665Z","caller":"traceutil/trace.go:171","msg":"trace[2068031682] transaction","detail":"{read_only:false; response_revision:4442; number_of_response:1; }","duration":"105.028038ms","start":"2026-06-24T11:07:11.777613Z","end":"2026-06-24T11:07:11.882641Z","steps":["trace[2068031682] 'process raft request' (duration: 104.968657ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:07:11.882735Z","caller":"traceutil/trace.go:171","msg":"trace[1876119078] transaction","detail":"{read_only:false; response_revision:4441; number_of_response:1; }","duration":"105.184213ms","start":"2026-06-24T11:07:11.777512Z","end":"2026-06-24T11:07:11.882696Z","steps":["trace[1876119078] 'process raft request' (duration: 105.027818ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:07:11.882708Z","caller":"traceutil/trace.go:171","msg":"trace[301510131] transaction","detail":"{read_only:false; response_revision:4440; number_of_response:1; }","duration":"106.100949ms","start":"2026-06-24T11:07:11.776561Z","end":"2026-06-24T11:07:11.882662Z","steps":["trace[301510131] 'process raft request' (duration: 105.849562ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:07:11.883064Z","caller":"traceutil/trace.go:171","msg":"trace[120166976] transaction","detail":"{read_only:false; response_revision:4445; number_of_response:1; }","duration":"104.889194ms","start":"2026-06-24T11:07:11.778157Z","end":"2026-06-24T11:07:11.883046Z","steps":["trace[120166976] 'process raft request' (duration: 104.797472ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:07:11.883156Z","caller":"traceutil/trace.go:171","msg":"trace[1276708095] transaction","detail":"{read_only:false; response_revision:4446; number_of_response:1; }","duration":"104.806442ms","start":"2026-06-24T11:07:11.778342Z","end":"2026-06-24T11:07:11.883148Z","steps":["trace[1276708095] 'process raft request' (duration: 104.643978ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:07:11.883246Z","caller":"traceutil/trace.go:171","msg":"trace[515543412] transaction","detail":"{read_only:false; response_revision:4443; number_of_response:1; }","duration":"105.09493ms","start":"2026-06-24T11:07:11.777986Z","end":"2026-06-24T11:07:11.883081Z","steps":["trace[515543412] 'process raft request' (duration: 104.626687ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:07:11.883333Z","caller":"traceutil/trace.go:171","msg":"trace[33867686] transaction","detail":"{read_only:false; response_revision:4444; number_of_response:1; }","duration":"104.886194ms","start":"2026-06-24T11:07:11.778131Z","end":"2026-06-24T11:07:11.883018Z","steps":["trace[33867686] 'process raft request' (duration: 104.73426ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:07:12.026491Z","caller":"traceutil/trace.go:171","msg":"trace[784199286] transaction","detail":"{read_only:false; response_revision:4455; number_of_response:1; }","duration":"133.447634ms","start":"2026-06-24T11:07:11.893002Z","end":"2026-06-24T11:07:12.02645Z","steps":["trace[784199286] 'process raft request' (duration: 133.278819ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:07:12.02666Z","caller":"traceutil/trace.go:171","msg":"trace[1909793711] transaction","detail":"{read_only:false; response_revision:4458; number_of_response:1; }","duration":"121.055442ms","start":"2026-06-24T11:07:11.905578Z","end":"2026-06-24T11:07:12.026633Z","steps":["trace[1909793711] 'process raft request' (duration: 120.846236ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:07:12.026735Z","caller":"traceutil/trace.go:171","msg":"trace[634963123] transaction","detail":"{read_only:false; response_revision:4456; number_of_response:1; }","duration":"132.927699ms","start":"2026-06-24T11:07:11.893778Z","end":"2026-06-24T11:07:12.026705Z","steps":["trace[634963123] 'process raft request' (duration: 132.541338ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:07:12.026894Z","caller":"traceutil/trace.go:171","msg":"trace[721375904] transaction","detail":"{read_only:false; response_revision:4453; number_of_response:1; }","duration":"136.717324ms","start":"2026-06-24T11:07:11.890153Z","end":"2026-06-24T11:07:12.02687Z","steps":["trace[721375904] 'process raft request' (duration: 73.91637ms)","trace[721375904] 'compare' (duration: 61.993671ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:07:12.026994Z","caller":"traceutil/trace.go:171","msg":"trace[1965973914] transaction","detail":"{read_only:false; response_revision:4454; number_of_response:1; }","duration":"136.653523ms","start":"2026-06-24T11:07:11.89032Z","end":"2026-06-24T11:07:12.026973Z","steps":["trace[1965973914] 'process raft request' (duration: 135.919612ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:07:12.027167Z","caller":"traceutil/trace.go:171","msg":"trace[504250002] transaction","detail":"{read_only:false; response_revision:4457; number_of_response:1; }","duration":"123.372206ms","start":"2026-06-24T11:07:11.903774Z","end":"2026-06-24T11:07:12.027146Z","steps":["trace[504250002] 'process raft request' (duration: 122.584393ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:07:21.078195Z","caller":"traceutil/trace.go:171","msg":"trace[277237962] linearizableReadLoop","detail":"{readStateIndex:4939; appliedIndex:4938; }","duration":"112.794496ms","start":"2026-06-24T11:07:20.965367Z","end":"2026-06-24T11:07:21.078161Z","steps":["trace[277237962] 'read index received' (duration: 71.104239ms)","trace[277237962] 'applied index is now lower than readState.Index' (duration: 41.688377ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:07:21.078646Z","caller":"traceutil/trace.go:171","msg":"trace[57896512] transaction","detail":"{read_only:false; response_revision:4755; number_of_response:1; }","duration":"114.942766ms","start":"2026-06-24T11:07:20.96366Z","end":"2026-06-24T11:07:21.078603Z","steps":["trace[57896512] 'process raft request' (duration: 72.59972ms)","trace[57896512] 'compare' (duration: 41.09651ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:07:21.079056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.6451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:3958"} {"level":"info","ts":"2026-06-24T11:07:21.079202Z","caller":"traceutil/trace.go:171","msg":"trace[619398982] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4755; }","duration":"113.848435ms","start":"2026-06-24T11:07:20.965331Z","end":"2026-06-24T11:07:21.079179Z","steps":["trace[619398982] 'agreement among raft nodes before linearized reading' (duration: 113.329731ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:07:21.098723Z","caller":"traceutil/trace.go:171","msg":"trace[332279730] transaction","detail":"{read_only:false; response_revision:4756; number_of_response:1; }","duration":"131.997673ms","start":"2026-06-24T11:07:20.966691Z","end":"2026-06-24T11:07:21.098688Z","steps":["trace[332279730] 'process raft request' (duration: 131.602352ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:07:21.211627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.42426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-06-24T11:07:21.211746Z","caller":"traceutil/trace.go:171","msg":"trace[613966690] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4757; }","duration":"120.656567ms","start":"2026-06-24T11:07:21.091064Z","end":"2026-06-24T11:07:21.21172Z","steps":["trace[613966690] 'agreement among raft nodes before linearized reading' (duration: 86.537402ms)","trace[613966690] 'range keys from in-memory index tree' (duration: 33.904899ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:07:21.212185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.334486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T11:07:21.212303Z","caller":"traceutil/trace.go:171","msg":"trace[568792440] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4758; }","duration":"111.49752ms","start":"2026-06-24T11:07:21.100778Z","end":"2026-06-24T11:07:21.212276Z","steps":["trace[568792440] 'agreement among raft nodes before linearized reading' (duration: 111.281494ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:07:21.21302Z","caller":"traceutil/trace.go:171","msg":"trace[1272261397] transaction","detail":"{read_only:false; response_revision:4758; number_of_response:1; }","duration":"109.384861ms","start":"2026-06-24T11:07:21.103612Z","end":"2026-06-24T11:07:21.212996Z","steps":["trace[1272261397] 'process raft request' (duration: 90.014519ms)","trace[1272261397] 'compare' (duration: 18.063215ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:07:21.301685Z","caller":"traceutil/trace.go:171","msg":"trace[1666180944] transaction","detail":"{read_only:false; response_revision:4759; number_of_response:1; }","duration":"116.932062ms","start":"2026-06-24T11:07:21.184726Z","end":"2026-06-24T11:07:21.301658Z","steps":["trace[1666180944] 'process raft request' (duration: 116.545731ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:07:21.302148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.627814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:11454"} {"level":"info","ts":"2026-06-24T11:07:21.302196Z","caller":"traceutil/trace.go:171","msg":"trace[1696850514] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4759; }","duration":"116.702555ms","start":"2026-06-24T11:07:21.185481Z","end":"2026-06-24T11:07:21.302184Z","steps":["trace[1696850514] 'agreement among raft nodes before linearized reading' (duration: 116.559521ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:07:28.688703Z","caller":"traceutil/trace.go:171","msg":"trace[128868354] transaction","detail":"{read_only:false; response_revision:4855; number_of_response:1; }","duration":"120.193715ms","start":"2026-06-24T11:07:28.56848Z","end":"2026-06-24T11:07:28.688673Z","steps":["trace[128868354] 'process raft request' (duration: 120.033491ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:07:28.689091Z","caller":"traceutil/trace.go:171","msg":"trace[683535957] linearizableReadLoop","detail":"{readStateIndex:5042; appliedIndex:5042; }","duration":"117.928221ms","start":"2026-06-24T11:07:28.571013Z","end":"2026-06-24T11:07:28.688942Z","steps":["trace[683535957] 'read index received' (duration: 117.91147ms)","trace[683535957] 'applied index is now lower than readState.Index' (duration: 14.811µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:07:28.689398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.351712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-06-24T11:07:28.689478Z","caller":"traceutil/trace.go:171","msg":"trace[2140007842] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4855; }","duration":"118.487506ms","start":"2026-06-24T11:07:28.570978Z","end":"2026-06-24T11:07:28.689466Z","steps":["trace[2140007842] 'agreement among raft nodes before linearized reading' (duration: 117.978642ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:07:29.244611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.495866ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T11:07:29.244725Z","caller":"traceutil/trace.go:171","msg":"trace[725378430] linearizableReadLoop","detail":"{readStateIndex:5043; appliedIndex:5042; }","duration":"555.496629ms","start":"2026-06-24T11:07:28.689208Z","end":"2026-06-24T11:07:29.244704Z","steps":["trace[725378430] 'read index received' (duration: 427.943192ms)","trace[725378430] 'applied index is now lower than readState.Index' (duration: 127.551847ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:07:29.244781Z","caller":"traceutil/trace.go:171","msg":"trace[552435154] transaction","detail":"{read_only:false; response_revision:4856; number_of_response:1; }","duration":"667.219444ms","start":"2026-06-24T11:07:28.577543Z","end":"2026-06-24T11:07:29.244763Z","steps":["trace[552435154] 'process raft request' (duration: 539.492951ms)","trace[552435154] 'compare' (duration: 127.121386ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:07:29.244866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:07:28.577526Z","time spent":"667.300326ms","remote":"127.0.0.1:56968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T11:07:29.244889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.369941ms","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-06-24T11:07:29.244921Z","caller":"traceutil/trace.go:171","msg":"trace[1480749429] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4856; }","duration":"660.437953ms","start":"2026-06-24T11:07:28.584472Z","end":"2026-06-24T11:07:29.24491Z","steps":["trace[1480749429] 'agreement among raft nodes before linearized reading' (duration: 660.31188ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:07:29.244954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:07:28.584438Z","time spent":"660.508775ms","remote":"127.0.0.1:56968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-24T11:07:29.245744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.062599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2362294"} {"level":"info","ts":"2026-06-24T11:07:29.245875Z","caller":"traceutil/trace.go:171","msg":"trace[352359233] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4856; }","duration":"605.211713ms","start":"2026-06-24T11:07:28.640629Z","end":"2026-06-24T11:07:29.245841Z","steps":["trace[352359233] 'agreement among raft nodes before linearized reading' (duration: 604.158064ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:07:29.245945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:07:28.640607Z","time spent":"605.325846ms","remote":"127.0.0.1:56832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":47,"response size":2362317,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"info","ts":"2026-06-24T11:07:29.404024Z","caller":"traceutil/trace.go:171","msg":"trace[607868238] transaction","detail":"{read_only:false; response_revision:4858; number_of_response:1; }","duration":"469.530307ms","start":"2026-06-24T11:07:28.934469Z","end":"2026-06-24T11:07:29.404Z","steps":["trace[607868238] 'process raft request' (duration: 469.390113ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:07:29.404261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:07:28.934422Z","time spent":"469.752352ms","remote":"127.0.0.1:56872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11112,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T11:07:29.404267Z","caller":"traceutil/trace.go:171","msg":"trace[1024876332] transaction","detail":"{read_only:false; response_revision:4857; number_of_response:1; }","duration":"709.911517ms","start":"2026-06-24T11:07:28.694304Z","end":"2026-06-24T11:07:29.404216Z","steps":["trace[1024876332] 'process raft request' (duration: 709.3578ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:07:29.404443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:07:28.694277Z","time spent":"710.080161ms","remote":"127.0.0.1:56804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":736,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T11:07:29.404624Z","caller":"traceutil/trace.go:171","msg":"trace[603956915] transaction","detail":"{read_only:false; response_revision:4859; number_of_response:1; }","duration":"311.460349ms","start":"2026-06-24T11:07:29.092505Z","end":"2026-06-24T11:07:29.403965Z","steps":["trace[603956915] 'process raft request' (duration: 311.417147ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:07:29.404754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:07:29.092471Z","time spent":"312.256871ms","remote":"127.0.0.1:56968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T11:07:29.413Z","caller":"traceutil/trace.go:171","msg":"trace[198077859] linearizableReadLoop","detail":"{readStateIndex:5047; appliedIndex:5043; }","duration":"168.225987ms","start":"2026-06-24T11:07:29.244753Z","end":"2026-06-24T11:07:29.412979Z","steps":["trace[198077859] 'read index received' (duration: 158.934164ms)","trace[198077859] 'applied index is now lower than readState.Index' (duration: 9.290743ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:07:29.413089Z","caller":"traceutil/trace.go:171","msg":"trace[1125817673] transaction","detail":"{read_only:false; response_revision:4860; number_of_response:1; }","duration":"283.041365ms","start":"2026-06-24T11:07:29.13003Z","end":"2026-06-24T11:07:29.413072Z","steps":["trace[1125817673] 'process raft request' (duration: 282.237912ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:07:29.413614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.69534ms","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-06-24T11:07:29.413726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.315643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1825"} {"level":"info","ts":"2026-06-24T11:07:29.413768Z","caller":"traceutil/trace.go:171","msg":"trace[1474279913] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4861; }","duration":"131.366295ms","start":"2026-06-24T11:07:29.282391Z","end":"2026-06-24T11:07:29.413757Z","steps":["trace[1474279913] 'agreement among raft nodes before linearized reading' (duration: 131.232531ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:07:29.413817Z","caller":"traceutil/trace.go:171","msg":"trace[1108274171] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4861; }","duration":"157.904665ms","start":"2026-06-24T11:07:29.255887Z","end":"2026-06-24T11:07:29.413792Z","steps":["trace[1108274171] 'agreement among raft nodes before linearized reading' (duration: 157.650028ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:07:29.413236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.006406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T11:07:29.414043Z","caller":"traceutil/trace.go:171","msg":"trace[1990196162] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:4861; }","duration":"495.829709ms","start":"2026-06-24T11:07:28.9182Z","end":"2026-06-24T11:07:29.41403Z","steps":["trace[1990196162] 'agreement among raft nodes before linearized reading' (duration: 494.925534ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:07:29.414111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:07:28.918125Z","time spent":"495.973763ms","remote":"127.0.0.1:57108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"warn","ts":"2026-06-24T11:07:29.413292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.891939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-06-24T11:07:29.414329Z","caller":"traceutil/trace.go:171","msg":"trace[191557465] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4861; }","duration":"543.968038ms","start":"2026-06-24T11:07:28.870349Z","end":"2026-06-24T11:07:29.414317Z","steps":["trace[191557465] 'agreement among raft nodes before linearized reading' (duration: 542.802686ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:07:29.41439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:07:28.87034Z","time spent":"544.02987ms","remote":"127.0.0.1:56868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2105,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"warn","ts":"2026-06-24T11:07:29.413297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.664157ms","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-06-24T11:07:29.414614Z","caller":"traceutil/trace.go:171","msg":"trace[737164823] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4861; }","duration":"553.055225ms","start":"2026-06-24T11:07:28.86155Z","end":"2026-06-24T11:07:29.414605Z","steps":["trace[737164823] 'agreement among raft nodes before linearized reading' (duration: 551.684297ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:07:29.414677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:07:28.861517Z","time spent":"553.135858ms","remote":"127.0.0.1:56968","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-06-24T11:07:29.413329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"710.189315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-06-24T11:07:29.415012Z","caller":"traceutil/trace.go:171","msg":"trace[1257817823] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4861; }","duration":"711.914432ms","start":"2026-06-24T11:07:28.703088Z","end":"2026-06-24T11:07:29.415002Z","steps":["trace[1257817823] 'agreement among raft nodes before linearized reading' (duration: 710.184454ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:07:29.413347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"719.142557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T11:07:29.413291Z","caller":"traceutil/trace.go:171","msg":"trace[728508428] transaction","detail":"{read_only:false; response_revision:4861; number_of_response:1; }","duration":"162.453514ms","start":"2026-06-24T11:07:29.250791Z","end":"2026-06-24T11:07:29.413245Z","steps":["trace[728508428] 'process raft request' (duration: 162.124855ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:07:29.413373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.03575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T11:07:29.413386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.557364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-85bcc85478-phm2v.18bbffb90fd0401d\" ","response":"range_response_count:1 size:898"} {"level":"warn","ts":"2026-06-24T11:07:29.413405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.783898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16232"} {"level":"warn","ts":"2026-06-24T11:07:29.41344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"642.284306ms","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-06-24T11:07:29.41543Z","caller":"traceutil/trace.go:171","msg":"trace[26534985] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1; range_end:; response_count:0; response_revision:4861; }","duration":"721.210365ms","start":"2026-06-24T11:07:28.694186Z","end":"2026-06-24T11:07:29.415396Z","steps":["trace[26534985] 'agreement among raft nodes before linearized reading' (duration: 719.141897ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:07:29.415484Z","caller":"traceutil/trace.go:171","msg":"trace[508067191] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4861; }","duration":"644.419566ms","start":"2026-06-24T11:07:28.771056Z","end":"2026-06-24T11:07:29.415476Z","steps":["trace[508067191] 'agreement among raft nodes before linearized reading' (duration: 642.127301ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:07:29.416171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:07:28.771029Z","time spent":"645.123966ms","remote":"127.0.0.1:56968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-24T11:07:29.415364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:07:28.703067Z","time spent":"712.282133ms","remote":"127.0.0.1:56968","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":"info","ts":"2026-06-24T11:07:29.415375Z","caller":"traceutil/trace.go:171","msg":"trace[724735420] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-85bcc85478-phm2v.18bbffb90fd0401d; range_end:; response_count:1; response_revision:4861; }","duration":"547.54353ms","start":"2026-06-24T11:07:28.867809Z","end":"2026-06-24T11:07:29.415352Z","steps":["trace[724735420] 'agreement among raft nodes before linearized reading' (duration: 545.510662ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:07:29.41648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:07:28.8678Z","time spent":"548.667841ms","remote":"127.0.0.1:56804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":93,"response count":1,"response size":921,"request content":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-85bcc85478-phm2v.18bbffb90fd0401d\" "} {"level":"info","ts":"2026-06-24T11:07:29.41541Z","caller":"traceutil/trace.go:171","msg":"trace[1065279522] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4861; }","duration":"548.844116ms","start":"2026-06-24T11:07:28.866555Z","end":"2026-06-24T11:07:29.415399Z","steps":["trace[1065279522] 'agreement among raft nodes before linearized reading' (duration: 546.562222ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:07:29.416612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:07:28.866511Z","time spent":"550.093501ms","remote":"127.0.0.1:56882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":16255,"request content":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"info","ts":"2026-06-24T11:07:29.415427Z","caller":"traceutil/trace.go:171","msg":"trace[1963327397] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:0; response_revision:4861; }","duration":"723.103739ms","start":"2026-06-24T11:07:28.692305Z","end":"2026-06-24T11:07:29.415409Z","steps":["trace[1963327397] 'agreement among raft nodes before linearized reading' (duration: 721.04659ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:07:29.416849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:07:28.69229Z","time spent":"724.540639ms","remote":"127.0.0.1:57154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":0,"response size":28,"request content":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" "} {"level":"warn","ts":"2026-06-24T11:07:29.415533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:07:28.694178Z","time spent":"721.319398ms","remote":"127.0.0.1:56824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":91,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1\" "} {"level":"info","ts":"2026-06-24T11:07:29.777067Z","caller":"traceutil/trace.go:171","msg":"trace[2091004467] linearizableReadLoop","detail":"{readStateIndex:5063; appliedIndex:5062; }","duration":"184.642242ms","start":"2026-06-24T11:07:29.592372Z","end":"2026-06-24T11:07:29.777014Z","steps":["trace[2091004467] 'read index received' (duration: 184.054196ms)","trace[2091004467] 'applied index is now lower than readState.Index' (duration: 586.396µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:07:29.777753Z","caller":"traceutil/trace.go:171","msg":"trace[944649752] transaction","detail":"{read_only:false; response_revision:4876; number_of_response:1; }","duration":"186.234547ms","start":"2026-06-24T11:07:29.591493Z","end":"2026-06-24T11:07:29.777728Z","steps":["trace[944649752] 'process raft request' (duration: 185.090715ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:07:29.778406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.0117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/openstack/\" range_end:\"/registry/limitranges/openstack0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T11:07:29.77845Z","caller":"traceutil/trace.go:171","msg":"trace[265599444] range","detail":"{range_begin:/registry/limitranges/openstack/; range_end:/registry/limitranges/openstack0; response_count:0; response_revision:4876; }","duration":"186.106823ms","start":"2026-06-24T11:07:29.59233Z","end":"2026-06-24T11:07:29.778437Z","steps":["trace[265599444] 'agreement among raft nodes before linearized reading' (duration: 186.00035ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:07:29.778752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.189945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1346"} {"level":"info","ts":"2026-06-24T11:07:29.778797Z","caller":"traceutil/trace.go:171","msg":"trace[241589630] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4876; }","duration":"186.255736ms","start":"2026-06-24T11:07:29.592527Z","end":"2026-06-24T11:07:29.778783Z","steps":["trace[241589630] 'agreement among raft nodes before linearized reading' (duration: 186.109132ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:07:29.782951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.15027ms","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-06-24T11:07:29.783032Z","caller":"traceutil/trace.go:171","msg":"trace[1762262431] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4876; }","duration":"189.250063ms","start":"2026-06-24T11:07:29.593765Z","end":"2026-06-24T11:07:29.783015Z","steps":["trace[1762262431] 'agreement among raft nodes before linearized reading' (duration: 185.347911ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:07:30.013158Z","caller":"traceutil/trace.go:171","msg":"trace[1830087193] transaction","detail":"{read_only:false; response_revision:4878; number_of_response:1; }","duration":"188.670815ms","start":"2026-06-24T11:07:29.824457Z","end":"2026-06-24T11:07:30.013128Z","steps":["trace[1830087193] 'process raft request' (duration: 188.525031ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:07:30.059366Z","caller":"traceutil/trace.go:171","msg":"trace[1204971484] transaction","detail":"{read_only:false; response_revision:4879; number_of_response:1; }","duration":"234.631126ms","start":"2026-06-24T11:07:29.824699Z","end":"2026-06-24T11:07:30.059331Z","steps":["trace[1204971484] 'process raft request' (duration: 234.271776ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:07:30.059408Z","caller":"traceutil/trace.go:171","msg":"trace[1235225650] linearizableReadLoop","detail":"{readStateIndex:5066; appliedIndex:5064; }","duration":"232.132196ms","start":"2026-06-24T11:07:29.827246Z","end":"2026-06-24T11:07:30.059378Z","steps":["trace[1235225650] 'read index received' (duration: 185.840845ms)","trace[1235225650] 'applied index is now lower than readState.Index' (duration: 46.290031ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:07:30.059594Z","caller":"traceutil/trace.go:171","msg":"trace[1205572054] transaction","detail":"{read_only:false; response_revision:4881; number_of_response:1; }","duration":"228.462313ms","start":"2026-06-24T11:07:29.831089Z","end":"2026-06-24T11:07:30.059551Z","steps":["trace[1205572054] 'process raft request' (duration: 228.220025ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:07:30.059437Z","caller":"traceutil/trace.go:171","msg":"trace[1652985757] transaction","detail":"{read_only:false; response_revision:4880; number_of_response:1; }","duration":"231.349135ms","start":"2026-06-24T11:07:29.828047Z","end":"2026-06-24T11:07:30.059396Z","steps":["trace[1652985757] 'process raft request' (duration: 231.20659ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:07:30.059767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.476807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"} {"level":"info","ts":"2026-06-24T11:07:30.059852Z","caller":"traceutil/trace.go:171","msg":"trace[1259564973] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:4881; }","duration":"232.624161ms","start":"2026-06-24T11:07:29.827206Z","end":"2026-06-24T11:07:30.05983Z","steps":["trace[1259564973] 'agreement among raft nodes before linearized reading' (duration: 232.365864ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:07:30.059947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.040128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-06-24T11:07:30.060007Z","caller":"traceutil/trace.go:171","msg":"trace[489283605] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4881; }","duration":"131.154941ms","start":"2026-06-24T11:07:29.928836Z","end":"2026-06-24T11:07:30.059991Z","steps":["trace[489283605] 'agreement among raft nodes before linearized reading' (duration: 130.955596ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:07:30.060652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.074911ms","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:4849"} {"level":"info","ts":"2026-06-24T11:07:30.060737Z","caller":"traceutil/trace.go:171","msg":"trace[717870274] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4881; }","duration":"229.174124ms","start":"2026-06-24T11:07:29.831541Z","end":"2026-06-24T11:07:30.060715Z","steps":["trace[717870274] 'agreement among raft nodes before linearized reading' (duration: 228.182356ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:07:33.175261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.824786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T11:07:33.175367Z","caller":"traceutil/trace.go:171","msg":"trace[1450528845] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4935; }","duration":"119.99263ms","start":"2026-06-24T11:07:33.055352Z","end":"2026-06-24T11:07:33.175344Z","steps":["trace[1450528845] 'range keys from in-memory index tree' (duration: 119.725303ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:07:45.177488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.121493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/\" range_end:\"/registry/monitoring.coreos.com/alertmanagers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T11:07:45.177607Z","caller":"traceutil/trace.go:171","msg":"trace[766212013] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/; range_end:/registry/monitoring.coreos.com/alertmanagers0; response_count:0; response_revision:5071; }","duration":"234.285688ms","start":"2026-06-24T11:07:44.943289Z","end":"2026-06-24T11:07:45.177574Z","steps":["trace[766212013] 'count revisions from in-memory index tree' (duration: 234.04428ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:07:45.177751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.019004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10392"} {"level":"info","ts":"2026-06-24T11:07:45.177844Z","caller":"traceutil/trace.go:171","msg":"trace[158790373] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5071; }","duration":"140.164029ms","start":"2026-06-24T11:07:45.037657Z","end":"2026-06-24T11:07:45.177821Z","steps":["trace[158790373] 'range keys from in-memory index tree' (duration: 139.800008ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:07:45.178129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.348522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T11:07:45.178179Z","caller":"traceutil/trace.go:171","msg":"trace[1695110628] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:5071; }","duration":"175.439164ms","start":"2026-06-24T11:07:45.002727Z","end":"2026-06-24T11:07:45.178166Z","steps":["trace[1695110628] 'count revisions from in-memory index tree' (duration: 175.267559ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:07:45.339335Z","caller":"traceutil/trace.go:171","msg":"trace[990920729] transaction","detail":"{read_only:false; response_revision:5072; number_of_response:1; }","duration":"148.381244ms","start":"2026-06-24T11:07:45.190929Z","end":"2026-06-24T11:07:45.339311Z","steps":["trace[990920729] 'process raft request' (duration: 148.24558ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:07:45.482514Z","caller":"traceutil/trace.go:171","msg":"trace[1084390350] transaction","detail":"{read_only:false; response_revision:5073; number_of_response:1; }","duration":"136.642797ms","start":"2026-06-24T11:07:45.345838Z","end":"2026-06-24T11:07:45.48248Z","steps":["trace[1084390350] 'process raft request' (duration: 37.78999ms)","trace[1084390350] 'compare' (duration: 98.570989ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:07:45.482765Z","caller":"traceutil/trace.go:171","msg":"trace[566510598] transaction","detail":"{read_only:false; response_revision:5074; number_of_response:1; }","duration":"136.536473ms","start":"2026-06-24T11:07:45.346205Z","end":"2026-06-24T11:07:45.482742Z","steps":["trace[566510598] 'process raft request' (duration: 136.193834ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:07:45.483025Z","caller":"traceutil/trace.go:171","msg":"trace[232130911] transaction","detail":"{read_only:false; response_revision:5076; number_of_response:1; }","duration":"136.595056ms","start":"2026-06-24T11:07:45.346405Z","end":"2026-06-24T11:07:45.483Z","steps":["trace[232130911] 'process raft request' (duration: 136.499333ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:07:45.48311Z","caller":"traceutil/trace.go:171","msg":"trace[104132289] transaction","detail":"{read_only:false; response_revision:5075; number_of_response:1; }","duration":"136.710599ms","start":"2026-06-24T11:07:45.346332Z","end":"2026-06-24T11:07:45.483043Z","steps":["trace[104132289] 'process raft request' (duration: 136.294307ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:07:45.499245Z","caller":"traceutil/trace.go:171","msg":"trace[994925297] transaction","detail":"{read_only:false; response_revision:5077; number_of_response:1; }","duration":"112.08134ms","start":"2026-06-24T11:07:45.387145Z","end":"2026-06-24T11:07:45.499226Z","steps":["trace[994925297] 'process raft request' (duration: 111.917985ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:08:23.663515Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2837} {"level":"info","ts":"2026-06-24T11:08:23.742616Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2837,"took":"77.268956ms","hash":1735090504,"current-db-size-bytes":53972992,"current-db-size":"54 MB","current-db-size-in-use-bytes":28999680,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-24T11:08:23.742677Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1735090504,"revision":2837,"compact-revision":-1} {"level":"info","ts":"2026-06-24T11:10:38.617767Z","caller":"traceutil/trace.go:171","msg":"trace[231076776] transaction","detail":"{read_only:false; response_revision:6256; number_of_response:1; }","duration":"108.779024ms","start":"2026-06-24T11:10:38.508953Z","end":"2026-06-24T11:10:38.617732Z","steps":["trace[231076776] 'process raft request' (duration: 108.547937ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:10:38.617972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.074208ms","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-06-24T11:10:38.618065Z","caller":"traceutil/trace.go:171","msg":"trace[1061528833] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6256; }","duration":"100.210201ms","start":"2026-06-24T11:10:38.517832Z","end":"2026-06-24T11:10:38.618042Z","steps":["trace[1061528833] 'agreement among raft nodes before linearized reading' (duration: 99.903181ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:10:38.930605Z","caller":"traceutil/trace.go:171","msg":"trace[1337131091] transaction","detail":"{read_only:false; response_revision:6264; number_of_response:1; }","duration":"123.399328ms","start":"2026-06-24T11:10:38.807186Z","end":"2026-06-24T11:10:38.930585Z","steps":["trace[1337131091] 'process raft request' (duration: 123.032417ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:13:23.670383Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5408} {"level":"info","ts":"2026-06-24T11:13:23.751778Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5408,"took":"80.049019ms","hash":1689248466,"current-db-size-bytes":53972992,"current-db-size":"54 MB","current-db-size-in-use-bytes":18472960,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-24T11:13:23.751862Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1689248466,"revision":5408,"compact-revision":2837} {"level":"info","ts":"2026-06-24T11:13:48.864138Z","caller":"traceutil/trace.go:171","msg":"trace[259959075] transaction","detail":"{read_only:false; response_revision:7487; number_of_response:1; }","duration":"108.906208ms","start":"2026-06-24T11:13:48.755208Z","end":"2026-06-24T11:13:48.864114Z","steps":["trace[259959075] 'process raft request' (duration: 108.736875ms)"],"step_count":1}