{"level":"warn","ts":"2026-06-24T00:47:56.784313Z","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-24T00:47:56.784513Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.70: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.70:2380","--initial-cluster=instance=https://199.204.45.70:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.70:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.70: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-24T00:47:56.784892Z","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-24T00:47:56.784945Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.70:2380"]} {"level":"info","ts":"2026-06-24T00:47:56.784992Z","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-24T00:47:56.785866Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"]} {"level":"info","ts":"2026-06-24T00:47:56.78601Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.70:2380"],"listen-peer-urls":["https://199.204.45.70:2380"],"advertise-client-urls":["https://199.204.45.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.70: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-24T00:47:56.789732Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.35555ms"} {"level":"info","ts":"2026-06-24T00:47:56.795098Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f8844a9a4263041d","cluster-id":"4749b7c221ae0648"} {"level":"info","ts":"2026-06-24T00:47:56.795218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=()"} {"level":"info","ts":"2026-06-24T00:47:56.795264Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 0"} {"level":"info","ts":"2026-06-24T00:47:56.795298Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f8844a9a4263041d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-24T00:47:56.795554Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 1"} {"level":"info","ts":"2026-06-24T00:47:56.795631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"} {"level":"warn","ts":"2026-06-24T00:47:56.800744Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-24T00:47:56.80204Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-24T00:47:56.803102Z","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-24T00:47:56.805097Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f8844a9a4263041d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-24T00:47:56.805292Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f8844a9a4263041d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-24T00:47:56.805808Z","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-24T00:47:56.805889Z","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-24T00:47:56.805916Z","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-24T00:47:56.810035Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"} {"level":"info","ts":"2026-06-24T00:47:56.810164Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4749b7c221ae0648","local-member-id":"f8844a9a4263041d","added-peer-id":"f8844a9a4263041d","added-peer-peer-urls":["https://199.204.45.70:2380"]} {"level":"info","ts":"2026-06-24T00:47:56.810324Z","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-24T00:47:56.810617Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f8844a9a4263041d","initial-advertise-peer-urls":["https://199.204.45.70:2380"],"listen-peer-urls":["https://199.204.45.70:2380"],"advertise-client-urls":["https://199.204.45.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-24T00:47:56.810647Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-24T00:47:56.810825Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.70:2380"} {"level":"info","ts":"2026-06-24T00:47:56.810853Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.70:2380"} {"level":"info","ts":"2026-06-24T00:47:57.59627Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d is starting a new election at term 1"} {"level":"info","ts":"2026-06-24T00:47:57.596335Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became pre-candidate at term 1"} {"level":"info","ts":"2026-06-24T00:47:57.596385Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgPreVoteResp from f8844a9a4263041d at term 1"} {"level":"info","ts":"2026-06-24T00:47:57.596413Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became candidate at term 2"} {"level":"info","ts":"2026-06-24T00:47:57.59643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgVoteResp from f8844a9a4263041d at term 2"} {"level":"info","ts":"2026-06-24T00:47:57.596451Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became leader at term 2"} {"level":"info","ts":"2026-06-24T00:47:57.596479Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f8844a9a4263041d elected leader f8844a9a4263041d at term 2"} {"level":"info","ts":"2026-06-24T00:47:57.597866Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T00:47:57.598823Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f8844a9a4263041d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.70:2379]}","request-path":"/0/members/f8844a9a4263041d/attributes","cluster-id":"4749b7c221ae0648","publish-timeout":"7s"} {"level":"info","ts":"2026-06-24T00:47:57.599071Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-24T00:47:57.599174Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-24T00:47:57.599422Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4749b7c221ae0648","local-member-id":"f8844a9a4263041d","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T00:47:57.599584Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T00:47:57.599635Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T00:47:57.602957Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.70:2379"} {"level":"info","ts":"2026-06-24T00:47:57.603034Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-24T00:47:57.603413Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-24T00:47:57.603466Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"warn","ts":"2026-06-24T00:48:39.410259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.408583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:48:39.410384Z","caller":"traceutil/trace.go:171","msg":"trace[1250558039] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:575; }","duration":"202.580299ms","start":"2026-06-24T00:48:39.207781Z","end":"2026-06-24T00:48:39.410361Z","steps":["trace[1250558039] 'range keys from in-memory index tree' (duration: 202.30705ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:39.410669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.180757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-24T00:48:39.410697Z","caller":"traceutil/trace.go:171","msg":"trace[8955291] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:575; }","duration":"148.24897ms","start":"2026-06-24T00:48:39.262439Z","end":"2026-06-24T00:48:39.410688Z","steps":["trace[8955291] 'range keys from in-memory index tree' (duration: 148.037612ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:39.410811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.785284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-24T00:48:39.410833Z","caller":"traceutil/trace.go:171","msg":"trace[723550628] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:575; }","duration":"147.824725ms","start":"2026-06-24T00:48:39.263001Z","end":"2026-06-24T00:48:39.410826Z","steps":["trace[723550628] 'range keys from in-memory index tree' (duration: 147.676171ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:39.698061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.445766ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T00:48:39.698247Z","caller":"traceutil/trace.go:171","msg":"trace[1570604406] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"274.043201ms","start":"2026-06-24T00:48:39.424188Z","end":"2026-06-24T00:48:39.698232Z","steps":["trace[1570604406] 'process raft request' (duration: 273.980709ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:48:39.698365Z","caller":"traceutil/trace.go:171","msg":"trace[1006893524] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"274.206627ms","start":"2026-06-24T00:48:39.424121Z","end":"2026-06-24T00:48:39.698328Z","steps":["trace[1006893524] 'process raft request' (duration: 88.949935ms)","trace[1006893524] 'compare' (duration: 184.226748ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:48:40.346466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.961246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:48:40.346586Z","caller":"traceutil/trace.go:171","msg":"trace[2095742764] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:578; }","duration":"528.122881ms","start":"2026-06-24T00:48:39.818435Z","end":"2026-06-24T00:48:40.346558Z","steps":["trace[2095742764] 'range keys from in-memory index tree' (duration: 527.866592ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:40.346655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:39.818417Z","time spent":"528.209314ms","remote":"127.0.0.1:38570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T00:48:40.352877Z","caller":"traceutil/trace.go:171","msg":"trace[923857543] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"518.989163ms","start":"2026-06-24T00:48:39.833871Z","end":"2026-06-24T00:48:40.35286Z","steps":["trace[923857543] 'process raft request' (duration: 518.548689ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:40.353042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:39.833849Z","time spent":"519.125498ms","remote":"127.0.0.1:38694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036105,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:48:40.357252Z","caller":"traceutil/trace.go:171","msg":"trace[1645242775] linearizableReadLoop","detail":"{readStateIndex:604; appliedIndex:602; }","duration":"267.801302ms","start":"2026-06-24T00:48:40.089429Z","end":"2026-06-24T00:48:40.357231Z","steps":["trace[1645242775] 'read index received' (duration: 262.813588ms)","trace[1645242775] 'applied index is now lower than readState.Index' (duration: 4.986664ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:48:40.35757Z","caller":"traceutil/trace.go:171","msg":"trace[1449953046] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"430.462631ms","start":"2026-06-24T00:48:39.927093Z","end":"2026-06-24T00:48:40.357555Z","steps":["trace[1449953046] 'process raft request' (duration: 430.026787ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:48:40.35768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:48:39.92707Z","time spent":"430.540075ms","remote":"127.0.0.1:38860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:48:40.357991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.558427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-5wwv6\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-06-24T00:48:40.358035Z","caller":"traceutil/trace.go:171","msg":"trace[200330942] range","detail":"{range_begin:/registry/pods/kube-system/cilium-5wwv6; range_end:; response_count:1; response_revision:580; }","duration":"268.63956ms","start":"2026-06-24T00:48:40.089385Z","end":"2026-06-24T00:48:40.358025Z","steps":["trace[200330942] 'agreement among raft nodes before linearized reading' (duration: 268.563207ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:49:33.939589Z","caller":"traceutil/trace.go:171","msg":"trace[2014369115] linearizableReadLoop","detail":"{readStateIndex:1228; appliedIndex:1227; }","duration":"129.69273ms","start":"2026-06-24T00:49:33.809873Z","end":"2026-06-24T00:49:33.939566Z","steps":["trace[2014369115] 'read index received' (duration: 129.514776ms)","trace[2014369115] 'applied index is now lower than readState.Index' (duration: 176.974µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:49:33.939631Z","caller":"traceutil/trace.go:171","msg":"trace[114779599] transaction","detail":"{read_only:false; response_revision:1189; number_of_response:1; }","duration":"147.920551ms","start":"2026-06-24T00:49:33.791687Z","end":"2026-06-24T00:49:33.939607Z","steps":["trace[114779599] 'process raft request' (duration: 147.744887ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:49:33.939852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.849595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:49:33.939897Z","caller":"traceutil/trace.go:171","msg":"trace[817938639] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1189; }","duration":"130.060898ms","start":"2026-06-24T00:49:33.809826Z","end":"2026-06-24T00:49:33.939887Z","steps":["trace[817938639] 'agreement among raft nodes before linearized reading' (duration: 129.861434ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:49:42.456694Z","caller":"traceutil/trace.go:171","msg":"trace[2035535362] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"104.001015ms","start":"2026-06-24T00:49:42.352673Z","end":"2026-06-24T00:49:42.456674Z","steps":["trace[2035535362] 'process raft request' (duration: 103.882303ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:50:19.857429Z","caller":"traceutil/trace.go:171","msg":"trace[582103103] transaction","detail":"{read_only:false; response_revision:1845; number_of_response:1; }","duration":"287.763979ms","start":"2026-06-24T00:50:19.569646Z","end":"2026-06-24T00:50:19.85741Z","steps":["trace[582103103] 'process raft request' (duration: 287.632287ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:50:19.857915Z","caller":"traceutil/trace.go:171","msg":"trace[1414168663] linearizableReadLoop","detail":"{readStateIndex:1920; appliedIndex:1920; }","duration":"285.876719ms","start":"2026-06-24T00:50:19.572032Z","end":"2026-06-24T00:50:19.857909Z","steps":["trace[1414168663] 'read index received' (duration: 285.873189ms)","trace[1414168663] 'applied index is now lower than readState.Index' (duration: 3.23µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:50:19.858108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.030881ms","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-24T00:50:19.858128Z","caller":"traceutil/trace.go:171","msg":"trace[670456209] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1845; }","duration":"286.121872ms","start":"2026-06-24T00:50:19.572001Z","end":"2026-06-24T00:50:19.858123Z","steps":["trace[670456209] 'agreement among raft nodes before linearized reading' (duration: 286.00374ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:50:20.016091Z","caller":"traceutil/trace.go:171","msg":"trace[25651926] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"154.147424ms","start":"2026-06-24T00:50:19.861919Z","end":"2026-06-24T00:50:20.016067Z","steps":["trace[25651926] 'process raft request' (duration: 132.367225ms)","trace[25651926] 'compare' (duration: 21.473975ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:50:20.114269Z","caller":"traceutil/trace.go:171","msg":"trace[365316626] linearizableReadLoop","detail":"{readStateIndex:1922; appliedIndex:1920; }","duration":"220.086029ms","start":"2026-06-24T00:50:19.894156Z","end":"2026-06-24T00:50:20.114242Z","steps":["trace[365316626] 'read index received' (duration: 100.157925ms)","trace[365316626] 'applied index is now lower than readState.Index' (duration: 119.927104ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:50:20.114335Z","caller":"traceutil/trace.go:171","msg":"trace[785690606] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"240.098543ms","start":"2026-06-24T00:50:19.874167Z","end":"2026-06-24T00:50:20.114265Z","steps":["trace[785690606] 'process raft request' (duration: 239.89764ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:50:20.114692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.513907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-24T00:50:20.114753Z","caller":"traceutil/trace.go:171","msg":"trace[173169333] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1847; }","duration":"220.620339ms","start":"2026-06-24T00:50:19.894118Z","end":"2026-06-24T00:50:20.114738Z","steps":["trace[173169333] 'agreement among raft nodes before linearized reading' (duration: 220.251772ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:50:20.259472Z","caller":"traceutil/trace.go:171","msg":"trace[782462002] transaction","detail":"{read_only:false; response_revision:1848; number_of_response:1; }","duration":"184.613593ms","start":"2026-06-24T00:50:20.074836Z","end":"2026-06-24T00:50:20.25945Z","steps":["trace[782462002] 'process raft request' (duration: 184.467041ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:50:20.279371Z","caller":"traceutil/trace.go:171","msg":"trace[1319661372] transaction","detail":"{read_only:false; response_revision:1849; number_of_response:1; }","duration":"158.88828ms","start":"2026-06-24T00:50:20.120423Z","end":"2026-06-24T00:50:20.279311Z","steps":["trace[1319661372] 'process raft request' (duration: 158.634846ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:50:20.279513Z","caller":"traceutil/trace.go:171","msg":"trace[1725242076] transaction","detail":"{read_only:false; response_revision:1851; number_of_response:1; }","duration":"158.444653ms","start":"2026-06-24T00:50:20.121041Z","end":"2026-06-24T00:50:20.279486Z","steps":["trace[1725242076] 'process raft request' (duration: 158.24338ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:50:20.279595Z","caller":"traceutil/trace.go:171","msg":"trace[647658741] transaction","detail":"{read_only:false; response_revision:1852; number_of_response:1; }","duration":"157.944145ms","start":"2026-06-24T00:50:20.121629Z","end":"2026-06-24T00:50:20.279573Z","steps":["trace[647658741] 'process raft request' (duration: 157.751022ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:50:20.279595Z","caller":"traceutil/trace.go:171","msg":"trace[953849640] linearizableReadLoop","detail":"{readStateIndex:1927; appliedIndex:1922; }","duration":"107.489445ms","start":"2026-06-24T00:50:20.171937Z","end":"2026-06-24T00:50:20.279427Z","steps":["trace[953849640] 'read index received' (duration: 87.332902ms)","trace[953849640] 'applied index is now lower than readState.Index' (duration: 20.155523ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:50:20.279794Z","caller":"traceutil/trace.go:171","msg":"trace[1764176309] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"158.840509ms","start":"2026-06-24T00:50:20.120835Z","end":"2026-06-24T00:50:20.279676Z","steps":["trace[1764176309] 'process raft request' (duration: 158.401692ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:50:20.280115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.70986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-06-24T00:50:20.280144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.830349ms","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-06-24T00:50:20.280201Z","caller":"traceutil/trace.go:171","msg":"trace[1567486613] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1853; }","duration":"100.92612ms","start":"2026-06-24T00:50:20.179259Z","end":"2026-06-24T00:50:20.280185Z","steps":["trace[1567486613] 'agreement among raft nodes before linearized reading' (duration: 100.699106ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:50:20.280179Z","caller":"traceutil/trace.go:171","msg":"trace[1605296126] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1853; }","duration":"102.804931ms","start":"2026-06-24T00:50:20.17736Z","end":"2026-06-24T00:50:20.280165Z","steps":["trace[1605296126] 'agreement among raft nodes before linearized reading' (duration: 102.566227ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:50:20.279902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.942723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-24T00:50:20.282199Z","caller":"traceutil/trace.go:171","msg":"trace[16164054] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1852; }","duration":"110.28202ms","start":"2026-06-24T00:50:20.171902Z","end":"2026-06-24T00:50:20.282184Z","steps":["trace[16164054] 'agreement among raft nodes before linearized reading' (duration: 107.818372ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:50:32.436398Z","caller":"traceutil/trace.go:171","msg":"trace[665676158] transaction","detail":"{read_only:false; response_revision:1952; number_of_response:1; }","duration":"121.255834ms","start":"2026-06-24T00:50:32.315125Z","end":"2026-06-24T00:50:32.436381Z","steps":["trace[665676158] 'process raft request' (duration: 121.138822ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:50:48.639897Z","caller":"traceutil/trace.go:171","msg":"trace[952557078] linearizableReadLoop","detail":"{readStateIndex:2139; appliedIndex:2137; }","duration":"133.449581ms","start":"2026-06-24T00:50:48.506419Z","end":"2026-06-24T00:50:48.639869Z","steps":["trace[952557078] 'read index received' (duration: 14.161385ms)","trace[952557078] 'applied index is now lower than readState.Index' (duration: 119.287586ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:50:48.639964Z","caller":"traceutil/trace.go:171","msg":"trace[575402406] transaction","detail":"{read_only:false; response_revision:2058; number_of_response:1; }","duration":"140.052387ms","start":"2026-06-24T00:50:48.499879Z","end":"2026-06-24T00:50:48.639931Z","steps":["trace[575402406] 'process raft request' (duration: 49.164672ms)","trace[575402406] 'compare' (duration: 90.208006ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:50:48.640188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.754906ms","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-06-24T00:50:48.640224Z","caller":"traceutil/trace.go:171","msg":"trace[1674252456] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2058; }","duration":"133.840286ms","start":"2026-06-24T00:50:48.506376Z","end":"2026-06-24T00:50:48.640216Z","steps":["trace[1674252456] 'agreement among raft nodes before linearized reading' (duration: 133.667534ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:50:48.64033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.879659ms","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-24T00:50:48.640438Z","caller":"traceutil/trace.go:171","msg":"trace[803936356] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2058; }","duration":"132.012061ms","start":"2026-06-24T00:50:48.508399Z","end":"2026-06-24T00:50:48.640411Z","steps":["trace[803936356] 'agreement among raft nodes before linearized reading' (duration: 131.735187ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:50:48.64058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.551935ms","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-06-24T00:50:48.640639Z","caller":"traceutil/trace.go:171","msg":"trace[2017482212] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2058; }","duration":"120.645697ms","start":"2026-06-24T00:50:48.51998Z","end":"2026-06-24T00:50:48.640626Z","steps":["trace[2017482212] 'agreement among raft nodes before linearized reading' (duration: 120.351602ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:50:48.640799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.522068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-06-24T00:50:48.640805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.054915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-06-24T00:50:48.641758Z","caller":"traceutil/trace.go:171","msg":"trace[1239180226] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2058; }","duration":"118.15697ms","start":"2026-06-24T00:50:48.52358Z","end":"2026-06-24T00:50:48.641737Z","steps":["trace[1239180226] 'agreement among raft nodes before linearized reading' (duration: 116.647127ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:50:48.640899Z","caller":"traceutil/trace.go:171","msg":"trace[197770503] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2058; }","duration":"114.591479ms","start":"2026-06-24T00:50:48.526241Z","end":"2026-06-24T00:50:48.640833Z","steps":["trace[197770503] 'agreement among raft nodes before linearized reading' (duration: 114.00908ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:50:54.48217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.881638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-24T00:50:54.482274Z","caller":"traceutil/trace.go:171","msg":"trace[2078659985] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2087; }","duration":"128.027571ms","start":"2026-06-24T00:50:54.354222Z","end":"2026-06-24T00:50:54.48225Z","steps":["trace[2078659985] 'range keys from in-memory index tree' (duration: 127.658515ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:50:54.803147Z","caller":"traceutil/trace.go:171","msg":"trace[1670304365] linearizableReadLoop","detail":"{readStateIndex:2171; appliedIndex:2170; }","duration":"137.542286ms","start":"2026-06-24T00:50:54.665593Z","end":"2026-06-24T00:50:54.803135Z","steps":["trace[1670304365] 'read index received' (duration: 99.08685ms)","trace[1670304365] 'applied index is now lower than readState.Index' (duration: 38.454026ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:50:54.803428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.618168ms","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-24T00:50:54.80347Z","caller":"traceutil/trace.go:171","msg":"trace[318010370] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2090; }","duration":"128.688989ms","start":"2026-06-24T00:50:54.674771Z","end":"2026-06-24T00:50:54.80346Z","steps":["trace[318010370] 'agreement among raft nodes before linearized reading' (duration: 128.475206ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:50:54.803909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.576418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-06-24T00:50:54.803967Z","caller":"traceutil/trace.go:171","msg":"trace[269221623] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2090; }","duration":"123.652038ms","start":"2026-06-24T00:50:54.680298Z","end":"2026-06-24T00:50:54.80395Z","steps":["trace[269221623] 'agreement among raft nodes before linearized reading' (duration: 123.528187ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:50:54.804019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.422366ms","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-24T00:50:54.804108Z","caller":"traceutil/trace.go:171","msg":"trace[1058154233] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2090; }","duration":"128.537347ms","start":"2026-06-24T00:50:54.675551Z","end":"2026-06-24T00:50:54.804088Z","steps":["trace[1058154233] 'agreement among raft nodes before linearized reading' (duration: 128.300704ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:50:54.804259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.717224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-24T00:50:54.804313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.004286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T00:50:54.804356Z","caller":"traceutil/trace.go:171","msg":"trace[1610511753] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:2090; }","duration":"120.068318ms","start":"2026-06-24T00:50:54.684277Z","end":"2026-06-24T00:50:54.804345Z","steps":["trace[1610511753] 'agreement among raft nodes before linearized reading' (duration: 119.718893ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:50:54.804344Z","caller":"traceutil/trace.go:171","msg":"trace[241038934] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2090; }","duration":"124.879447ms","start":"2026-06-24T00:50:54.679446Z","end":"2026-06-24T00:50:54.804325Z","steps":["trace[241038934] 'agreement among raft nodes before linearized reading' (duration: 124.542632ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:50:54.803111Z","caller":"traceutil/trace.go:171","msg":"trace[1298462824] transaction","detail":"{read_only:false; response_revision:2089; number_of_response:1; }","duration":"147.452896ms","start":"2026-06-24T00:50:54.655631Z","end":"2026-06-24T00:50:54.803084Z","steps":["trace[1298462824] 'process raft request' (duration: 109.029651ms)","trace[1298462824] 'compare' (duration: 38.05551ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:50:54.805394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.794068ms","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-06-24T00:50:54.805451Z","caller":"traceutil/trace.go:171","msg":"trace[733405944] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2090; }","duration":"139.882909ms","start":"2026-06-24T00:50:54.665552Z","end":"2026-06-24T00:50:54.805434Z","steps":["trace[733405944] 'agreement among raft nodes before linearized reading' (duration: 137.673407ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:50:56.388305Z","caller":"traceutil/trace.go:171","msg":"trace[991458322] linearizableReadLoop","detail":"{readStateIndex:2180; appliedIndex:2179; }","duration":"114.57827ms","start":"2026-06-24T00:50:56.273704Z","end":"2026-06-24T00:50:56.388282Z","steps":["trace[991458322] 'read index received' (duration: 114.427288ms)","trace[991458322] 'applied index is now lower than readState.Index' (duration: 150.052µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:50:56.388348Z","caller":"traceutil/trace.go:171","msg":"trace[970241913] transaction","detail":"{read_only:false; response_revision:2097; number_of_response:1; }","duration":"146.192257ms","start":"2026-06-24T00:50:56.242133Z","end":"2026-06-24T00:50:56.388326Z","steps":["trace[970241913] 'process raft request' (duration: 145.983714ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:50:56.38843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.700042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T00:50:56.388465Z","caller":"traceutil/trace.go:171","msg":"trace[764288699] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:2097; }","duration":"114.779372ms","start":"2026-06-24T00:50:56.273675Z","end":"2026-06-24T00:50:56.388454Z","steps":["trace[764288699] 'agreement among raft nodes before linearized reading' (duration: 114.694841ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:51:56.864634Z","caller":"traceutil/trace.go:171","msg":"trace[1116476007] transaction","detail":"{read_only:false; response_revision:2526; number_of_response:1; }","duration":"190.32754ms","start":"2026-06-24T00:51:56.674281Z","end":"2026-06-24T00:51:56.864608Z","steps":["trace[1116476007] 'process raft request' (duration: 190.178527ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:51:56.985725Z","caller":"traceutil/trace.go:171","msg":"trace[2121470826] linearizableReadLoop","detail":"{readStateIndex:2624; appliedIndex:2622; }","duration":"177.278336ms","start":"2026-06-24T00:51:56.808424Z","end":"2026-06-24T00:51:56.985702Z","steps":["trace[2121470826] 'read index received' (duration: 56.020767ms)","trace[2121470826] 'applied index is now lower than readState.Index' (duration: 121.256579ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:51:56.985865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.417638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:51:56.985903Z","caller":"traceutil/trace.go:171","msg":"trace[431566286] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2527; }","duration":"177.471868ms","start":"2026-06-24T00:51:56.808419Z","end":"2026-06-24T00:51:56.985891Z","steps":["trace[431566286] 'agreement among raft nodes before linearized reading' (duration: 177.383107ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:51:56.986339Z","caller":"traceutil/trace.go:171","msg":"trace[1275820892] transaction","detail":"{read_only:false; response_revision:2527; number_of_response:1; }","duration":"189.293216ms","start":"2026-06-24T00:51:56.797018Z","end":"2026-06-24T00:51:56.986312Z","steps":["trace[1275820892] 'process raft request' (duration: 186.984777ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:43.396353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.398011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-24T00:56:43.396385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.693126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/openstack/\" range_end:\"/registry/resourcequotas/openstack0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:56:43.396478Z","caller":"traceutil/trace.go:171","msg":"trace[1021371897] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:4759; }","duration":"170.580435ms","start":"2026-06-24T00:56:43.225865Z","end":"2026-06-24T00:56:43.396445Z","steps":["trace[1021371897] 'count revisions from in-memory index tree' (duration: 170.29882ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:43.396491Z","caller":"traceutil/trace.go:171","msg":"trace[839435833] range","detail":"{range_begin:/registry/resourcequotas/openstack/; range_end:/registry/resourcequotas/openstack0; response_count:0; response_revision:4759; }","duration":"223.854008ms","start":"2026-06-24T00:56:43.172609Z","end":"2026-06-24T00:56:43.396463Z","steps":["trace[839435833] 'range keys from in-memory index tree' (duration: 223.596564ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:43.512366Z","caller":"traceutil/trace.go:171","msg":"trace[2035632872] linearizableReadLoop","detail":"{readStateIndex:4944; appliedIndex:4943; }","duration":"111.128204ms","start":"2026-06-24T00:56:43.401216Z","end":"2026-06-24T00:56:43.512344Z","steps":["trace[2035632872] 'read index received' (duration: 75.980052ms)","trace[2035632872] 'applied index is now lower than readState.Index' (duration: 35.147222ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:56:43.512625Z","caller":"traceutil/trace.go:171","msg":"trace[1821235645] transaction","detail":"{read_only:false; response_revision:4762; number_of_response:1; }","duration":"104.449908ms","start":"2026-06-24T00:56:43.408145Z","end":"2026-06-24T00:56:43.512594Z","steps":["trace[1821235645] 'process raft request' (duration: 104.134602ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:43.512679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.46765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-c3a79162-a881-47a6-81bb-d40d04e0e58c\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-06-24T00:56:43.512685Z","caller":"traceutil/trace.go:171","msg":"trace[2130621448] transaction","detail":"{read_only:false; response_revision:4761; number_of_response:1; }","duration":"112.834926ms","start":"2026-06-24T00:56:43.399827Z","end":"2026-06-24T00:56:43.512662Z","steps":["trace[2130621448] 'process raft request' (duration: 112.330167ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:43.512902Z","caller":"traceutil/trace.go:171","msg":"trace[194266085] range","detail":"{range_begin:/registry/persistentvolumes/pvc-c3a79162-a881-47a6-81bb-d40d04e0e58c; range_end:; response_count:1; response_revision:4762; }","duration":"111.585512ms","start":"2026-06-24T00:56:43.401138Z","end":"2026-06-24T00:56:43.512723Z","steps":["trace[194266085] 'agreement among raft nodes before linearized reading' (duration: 111.292756ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:44.073379Z","caller":"traceutil/trace.go:171","msg":"trace[892998817] transaction","detail":"{read_only:false; response_revision:4775; number_of_response:1; }","duration":"237.84286ms","start":"2026-06-24T00:56:43.835514Z","end":"2026-06-24T00:56:44.073357Z","steps":["trace[892998817] 'process raft request' (duration: 229.635476ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:44.38801Z","caller":"traceutil/trace.go:171","msg":"trace[1630353742] transaction","detail":"{read_only:false; response_revision:4793; number_of_response:1; }","duration":"100.209426ms","start":"2026-06-24T00:56:44.287777Z","end":"2026-06-24T00:56:44.387986Z","steps":["trace[1630353742] 'process raft request' (duration: 59.141193ms)","trace[1630353742] 'compare' (duration: 40.125174ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:56:44.388445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.897499ms","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-24T00:56:44.388504Z","caller":"traceutil/trace.go:171","msg":"trace[1213923297] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4793; }","duration":"101.0012ms","start":"2026-06-24T00:56:44.287489Z","end":"2026-06-24T00:56:44.38849Z","steps":["trace[1213923297] 'agreement among raft nodes before linearized reading' (duration: 100.892498ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:55.763582Z","caller":"traceutil/trace.go:171","msg":"trace[257917092] linearizableReadLoop","detail":"{readStateIndex:5165; appliedIndex:5164; }","duration":"307.106485ms","start":"2026-06-24T00:56:55.456453Z","end":"2026-06-24T00:56:55.76356Z","steps":["trace[257917092] 'read index received' (duration: 306.92273ms)","trace[257917092] 'applied index is now lower than readState.Index' (duration: 182.665µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:56:55.763923Z","caller":"traceutil/trace.go:171","msg":"trace[822109648] transaction","detail":"{read_only:false; response_revision:4976; number_of_response:1; }","duration":"316.253293ms","start":"2026-06-24T00:56:55.447655Z","end":"2026-06-24T00:56:55.763908Z","steps":["trace[822109648] 'process raft request' (duration: 315.717142ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:55.76403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:55.447641Z","time spent":"316.317255ms","remote":"127.0.0.1:38778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10666,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:56:55.76421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.762136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-06-24T00:56:55.764249Z","caller":"traceutil/trace.go:171","msg":"trace[1002815829] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4976; }","duration":"307.817977ms","start":"2026-06-24T00:56:55.456418Z","end":"2026-06-24T00:56:55.764236Z","steps":["trace[1002815829] 'agreement among raft nodes before linearized reading' (duration: 307.710545ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:55.764278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:55.456405Z","time spent":"307.865177ms","remote":"127.0.0.1:38748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-06-24T00:56:55.956307Z","caller":"traceutil/trace.go:171","msg":"trace[1573114343] transaction","detail":"{read_only:false; response_revision:4981; number_of_response:1; }","duration":"143.709749ms","start":"2026-06-24T00:56:55.812578Z","end":"2026-06-24T00:56:55.956288Z","steps":["trace[1573114343] 'process raft request' (duration: 143.594677ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:55.956337Z","caller":"traceutil/trace.go:171","msg":"trace[506153331] linearizableReadLoop","detail":"{readStateIndex:5170; appliedIndex:5170; }","duration":"143.468795ms","start":"2026-06-24T00:56:55.812841Z","end":"2026-06-24T00:56:55.95631Z","steps":["trace[506153331] 'read index received' (duration: 143.461115ms)","trace[506153331] 'applied index is now lower than readState.Index' (duration: 6.16µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:56:55.956471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.064383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:56:55.956499Z","caller":"traceutil/trace.go:171","msg":"trace[1356389743] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4981; }","duration":"146.154624ms","start":"2026-06-24T00:56:55.810337Z","end":"2026-06-24T00:56:55.956492Z","steps":["trace[1356389743] 'agreement among raft nodes before linearized reading' (duration: 146.062762ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:57.63114Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2860} {"level":"info","ts":"2026-06-24T00:57:57.722194Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2860,"took":"89.446028ms","hash":1999095616,"current-db-size-bytes":53215232,"current-db-size":"53 MB","current-db-size-in-use-bytes":28635136,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-24T00:57:57.722242Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1999095616,"revision":2860,"compact-revision":-1} {"level":"warn","ts":"2026-06-24T01:01:03.263693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.006547ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T01:01:03.263848Z","caller":"traceutil/trace.go:171","msg":"trace[1638163772] transaction","detail":"{read_only:false; response_revision:6783; number_of_response:1; }","duration":"179.713067ms","start":"2026-06-24T01:01:03.084121Z","end":"2026-06-24T01:01:03.263834Z","steps":["trace[1638163772] 'process raft request' (duration: 179.671176ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T01:01:03.264104Z","caller":"traceutil/trace.go:171","msg":"trace[1761215257] transaction","detail":"{read_only:false; response_revision:6782; number_of_response:1; }","duration":"180.456043ms","start":"2026-06-24T01:01:03.08364Z","end":"2026-06-24T01:01:03.264096Z","steps":["trace[1761215257] 'process raft request' (duration: 50.974681ms)","trace[1761215257] 'compare' (duration: 128.874072ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T01:02:57.637248Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5478} {"level":"info","ts":"2026-06-24T01:02:57.729416Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5478,"took":"90.497941ms","hash":1795189487,"current-db-size-bytes":53215232,"current-db-size":"53 MB","current-db-size-in-use-bytes":18358272,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-24T01:02:57.729538Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1795189487,"revision":5478,"compact-revision":2860}