{"level":"warn","ts":"2026-05-09T12:53:54.566315Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-09T12:53:54.566407Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.38: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.38:2380","--initial-cluster=instance=https://199.204.45.38:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.38:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.38:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-09T12:53:54.56647Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-09T12:53:54.566482Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-05-09T12:53:54.5665Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-09T12:53:54.567068Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"]} {"level":"info","ts":"2026-05-09T12:53:54.567138Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.38:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-09T12:53:54.571012Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.683573ms"} {"level":"info","ts":"2026-05-09T12:53:54.577366Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"331455d6226d3423","cluster-id":"25c7803fb83a1455"} {"level":"info","ts":"2026-05-09T12:53:54.57743Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=()"} {"level":"info","ts":"2026-05-09T12:53:54.577449Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 0"} {"level":"info","ts":"2026-05-09T12:53:54.577469Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 331455d6226d3423 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-09T12:53:54.57748Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 1"} {"level":"info","ts":"2026-05-09T12:53:54.577521Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"warn","ts":"2026-05-09T12:53:54.583429Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-09T12:53:54.585195Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-09T12:53:54.586999Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-09T12:53:54.592314Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"331455d6226d3423","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-09T12:53:54.592466Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"331455d6226d3423","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-09T12:53:54.592696Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-09T12:53:54.59296Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-09T12:53:54.593066Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-09T12:53:54.595912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"info","ts":"2026-05-09T12:53:54.596067Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","added-peer-id":"331455d6226d3423","added-peer-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-05-09T12:53:54.596749Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-09T12:53:54.596882Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-05-09T12:53:54.596915Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-05-09T12:53:54.597086Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"331455d6226d3423","initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-09T12:53:54.597136Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-09T12:53:54.678584Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 is starting a new election at term 1"} {"level":"info","ts":"2026-05-09T12:53:54.678674Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-09T12:53:54.678702Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgPreVoteResp from 331455d6226d3423 at term 1"} {"level":"info","ts":"2026-05-09T12:53:54.678725Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became candidate at term 2"} {"level":"info","ts":"2026-05-09T12:53:54.678738Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgVoteResp from 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-05-09T12:53:54.678762Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became leader at term 2"} {"level":"info","ts":"2026-05-09T12:53:54.678777Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 331455d6226d3423 elected leader 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-05-09T12:53:54.679643Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T12:53:54.680376Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-09T12:53:54.680379Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"331455d6226d3423","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.38:2379]}","request-path":"/0/members/331455d6226d3423/attributes","cluster-id":"25c7803fb83a1455","publish-timeout":"7s"} {"level":"info","ts":"2026-05-09T12:53:54.68043Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-09T12:53:54.680716Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-09T12:53:54.680772Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-09T12:53:54.68094Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T12:53:54.681161Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T12:53:54.681261Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T12:53:54.686551Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.38:2379"} {"level":"info","ts":"2026-05-09T12:53:54.6873Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-09T12:54:29.422784Z","caller":"traceutil/trace.go:171","msg":"trace[949776743] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"227.075827ms","start":"2026-05-09T12:54:29.195666Z","end":"2026-05-09T12:54:29.422742Z","steps":["trace[949776743] 'process raft request' (duration: 225.71327ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:54:29.423021Z","caller":"traceutil/trace.go:171","msg":"trace[473548319] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:632; }","duration":"155.658933ms","start":"2026-05-09T12:54:29.266908Z","end":"2026-05-09T12:54:29.422567Z","steps":["trace[473548319] 'read index received' (duration: 154.535042ms)","trace[473548319] 'applied index is now lower than readState.Index' (duration: 871.504µs)"],"step_count":2} {"level":"warn","ts":"2026-05-09T12:54:29.422948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.010763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:54:29.42321Z","caller":"traceutil/trace.go:171","msg":"trace[1287722010] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:612; }","duration":"156.226159ms","start":"2026-05-09T12:54:29.266887Z","end":"2026-05-09T12:54:29.423113Z","steps":["trace[1287722010] 'agreement among raft nodes before linearized reading' (duration: 155.696344ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:54:29.65009Z","caller":"traceutil/trace.go:171","msg":"trace[737099105] linearizableReadLoop","detail":"{readStateIndex:634; appliedIndex:633; }","duration":"225.076771ms","start":"2026-05-09T12:54:29.424982Z","end":"2026-05-09T12:54:29.650059Z","steps":["trace[737099105] 'read index received' (duration: 224.371972ms)","trace[737099105] 'applied index is now lower than readState.Index' (duration: 703.899µs)"],"step_count":2} {"level":"warn","ts":"2026-05-09T12:54:29.650224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.216215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:54:29.65025Z","caller":"traceutil/trace.go:171","msg":"trace[142865578] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:613; }","duration":"225.309257ms","start":"2026-05-09T12:54:29.424931Z","end":"2026-05-09T12:54:29.65024Z","steps":["trace[142865578] 'agreement among raft nodes before linearized reading' (duration: 225.231135ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:54:29.650238Z","caller":"traceutil/trace.go:171","msg":"trace[517453981] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"357.204413ms","start":"2026-05-09T12:54:29.292996Z","end":"2026-05-09T12:54:29.6502Z","steps":["trace[517453981] 'process raft request' (duration: 356.557865ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:54:29.650857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:54:29.292958Z","time spent":"357.359767ms","remote":"127.0.0.1:33404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T12:54:30.033416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.51453ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-09T12:54:30.033555Z","caller":"traceutil/trace.go:171","msg":"trace[480242622] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"323.348058ms","start":"2026-05-09T12:54:29.710184Z","end":"2026-05-09T12:54:30.033532Z","steps":["trace[480242622] 'process raft request' (duration: 40.469878ms)","trace[480242622] 'compare' (duration: 282.336615ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T12:54:30.033641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:54:29.710153Z","time spent":"323.44132ms","remote":"127.0.0.1:33776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T12:54:31.431776Z","caller":"traceutil/trace.go:171","msg":"trace[1684374104] linearizableReadLoop","detail":"{readStateIndex:661; appliedIndex:660; }","duration":"101.714521ms","start":"2026-05-09T12:54:31.330036Z","end":"2026-05-09T12:54:31.431751Z","steps":["trace[1684374104] 'read index received' (duration: 101.68897ms)","trace[1684374104] 'applied index is now lower than readState.Index' (duration: 24.391µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:54:31.431799Z","caller":"traceutil/trace.go:171","msg":"trace[489705549] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"101.900477ms","start":"2026-05-09T12:54:31.329873Z","end":"2026-05-09T12:54:31.431773Z","steps":["trace[489705549] 'process raft request' (duration: 101.734302ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:54:31.431908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.846465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:54:31.431961Z","caller":"traceutil/trace.go:171","msg":"trace[311722197] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:0; response_revision:640; }","duration":"101.932917ms","start":"2026-05-09T12:54:31.330011Z","end":"2026-05-09T12:54:31.431944Z","steps":["trace[311722197] 'agreement among raft nodes before linearized reading' (duration: 101.838335ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:54:31.437296Z","caller":"traceutil/trace.go:171","msg":"trace[443037171] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"104.242131ms","start":"2026-05-09T12:54:31.333017Z","end":"2026-05-09T12:54:31.437259Z","steps":["trace[443037171] 'process raft request' (duration: 103.988254ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:54:31.437377Z","caller":"traceutil/trace.go:171","msg":"trace[512600687] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"104.19795ms","start":"2026-05-09T12:54:31.333145Z","end":"2026-05-09T12:54:31.437343Z","steps":["trace[512600687] 'process raft request' (duration: 104.036316ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:54:31.437465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.992507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:54:31.437529Z","caller":"traceutil/trace.go:171","msg":"trace[189898770] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:642; }","duration":"107.08481ms","start":"2026-05-09T12:54:31.330428Z","end":"2026-05-09T12:54:31.437512Z","steps":["trace[189898770] 'agreement among raft nodes before linearized reading' (duration: 106.929896ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:54:31.437376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.243404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:54:31.43777Z","caller":"traceutil/trace.go:171","msg":"trace[2122366378] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:0; response_revision:642; }","duration":"107.676836ms","start":"2026-05-09T12:54:31.330066Z","end":"2026-05-09T12:54:31.437743Z","steps":["trace[2122366378] 'agreement among raft nodes before linearized reading' (duration: 107.172483ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:54:44.355394Z","caller":"traceutil/trace.go:171","msg":"trace[2004824364] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"100.422515ms","start":"2026-05-09T12:54:44.254938Z","end":"2026-05-09T12:54:44.35536Z","steps":["trace[2004824364] 'process raft request' (duration: 100.123247ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:54:44.544214Z","caller":"traceutil/trace.go:171","msg":"trace[458331596] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"183.76706ms","start":"2026-05-09T12:54:44.360416Z","end":"2026-05-09T12:54:44.544183Z","steps":["trace[458331596] 'process raft request' (duration: 183.596625ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:54:44.549834Z","caller":"traceutil/trace.go:171","msg":"trace[1197580141] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"186.919877ms","start":"2026-05-09T12:54:44.362889Z","end":"2026-05-09T12:54:44.549809Z","steps":["trace[1197580141] 'process raft request' (duration: 186.777984ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:55:16.871166Z","caller":"traceutil/trace.go:171","msg":"trace[2084146699] linearizableReadLoop","detail":"{readStateIndex:1213; appliedIndex:1212; }","duration":"168.313652ms","start":"2026-05-09T12:55:16.702824Z","end":"2026-05-09T12:55:16.871138Z","steps":["trace[2084146699] 'read index received' (duration: 168.074646ms)","trace[2084146699] 'applied index is now lower than readState.Index' (duration: 237.906µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:55:16.871264Z","caller":"traceutil/trace.go:171","msg":"trace[1906115713] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"169.115245ms","start":"2026-05-09T12:55:16.702119Z","end":"2026-05-09T12:55:16.871235Z","steps":["trace[1906115713] 'process raft request' (duration: 168.871117ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:55:16.871379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.452401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:55:16.87145Z","caller":"traceutil/trace.go:171","msg":"trace[38433784] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1181; }","duration":"107.563044ms","start":"2026-05-09T12:55:16.763867Z","end":"2026-05-09T12:55:16.87143Z","steps":["trace[38433784] 'agreement among raft nodes before linearized reading' (duration: 107.449151ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:55:16.871447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.601631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-09T12:55:16.87152Z","caller":"traceutil/trace.go:171","msg":"trace[888673294] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1181; }","duration":"168.726534ms","start":"2026-05-09T12:55:16.702778Z","end":"2026-05-09T12:55:16.871505Z","steps":["trace[888673294] 'agreement among raft nodes before linearized reading' (duration: 168.524479ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:56:01.997886Z","caller":"traceutil/trace.go:171","msg":"trace[2058853909] transaction","detail":"{read_only:false; response_revision:1849; number_of_response:1; }","duration":"307.938366ms","start":"2026-05-09T12:56:01.689928Z","end":"2026-05-09T12:56:01.997866Z","steps":["trace[2058853909] 'process raft request' (duration: 307.805882ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:56:01.99802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:56:01.689902Z","time spent":"308.047219ms","remote":"127.0.0.1:33488","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3725,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T12:56:02.073317Z","caller":"traceutil/trace.go:171","msg":"trace[680155147] linearizableReadLoop","detail":"{readStateIndex:1916; appliedIndex:1914; }","duration":"318.039384ms","start":"2026-05-09T12:56:01.755252Z","end":"2026-05-09T12:56:02.073291Z","steps":["trace[680155147] 'read index received' (duration: 242.593182ms)","trace[680155147] 'applied index is now lower than readState.Index' (duration: 75.445292ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:56:02.073365Z","caller":"traceutil/trace.go:171","msg":"trace[1789677969] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"368.97597ms","start":"2026-05-09T12:56:01.704359Z","end":"2026-05-09T12:56:02.073335Z","steps":["trace[1789677969] 'process raft request' (duration: 354.125141ms)","trace[1789677969] 'compare' (duration: 14.701155ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T12:56:02.073543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.247119ms","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-05-09T12:56:02.073658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.569462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-09T12:56:02.0737Z","caller":"traceutil/trace.go:171","msg":"trace[1219594311] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:1850; }","duration":"318.446995ms","start":"2026-05-09T12:56:01.75521Z","end":"2026-05-09T12:56:02.073657Z","steps":["trace[1219594311] 'agreement among raft nodes before linearized reading' (duration: 318.222238ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:56:02.073684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:56:01.704332Z","time spent":"369.190186ms","remote":"127.0.0.1:33560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T12:56:02.07381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.121577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-09T12:56:02.073851Z","caller":"traceutil/trace.go:171","msg":"trace[955641144] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1850; }","duration":"114.178989ms","start":"2026-05-09T12:56:01.959659Z","end":"2026-05-09T12:56:02.073838Z","steps":["trace[955641144] 'agreement among raft nodes before linearized reading' (duration: 114.083487ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:56:02.073776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:56:01.755194Z","time spent":"318.567128ms","remote":"127.0.0.1:39118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"info","ts":"2026-05-09T12:56:02.073719Z","caller":"traceutil/trace.go:171","msg":"trace[1190366217] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1850; }","duration":"138.671145ms","start":"2026-05-09T12:56:01.935034Z","end":"2026-05-09T12:56:02.073706Z","steps":["trace[1190366217] 'agreement among raft nodes before linearized reading' (duration: 138.462739ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:56:33.4141Z","caller":"traceutil/trace.go:171","msg":"trace[1294419971] transaction","detail":"{read_only:false; response_revision:2060; number_of_response:1; }","duration":"285.906548ms","start":"2026-05-09T12:56:33.12816Z","end":"2026-05-09T12:56:33.414067Z","steps":["trace[1294419971] 'process raft request' (duration: 285.680972ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:56:33.420978Z","caller":"traceutil/trace.go:171","msg":"trace[1969497556] transaction","detail":"{read_only:false; response_revision:2061; number_of_response:1; }","duration":"108.413782ms","start":"2026-05-09T12:56:33.312546Z","end":"2026-05-09T12:56:33.42096Z","steps":["trace[1969497556] 'process raft request' (duration: 108.189436ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:56:33.42418Z","caller":"traceutil/trace.go:171","msg":"trace[1514585984] linearizableReadLoop","detail":"{readStateIndex:2135; appliedIndex:2132; }","duration":"100.663838ms","start":"2026-05-09T12:56:33.323484Z","end":"2026-05-09T12:56:33.424148Z","steps":["trace[1514585984] 'read index received' (duration: 90.368855ms)","trace[1514585984] 'applied index is now lower than readState.Index' (duration: 10.292393ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T12:56:33.424558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.057008ms","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-05-09T12:56:33.424625Z","caller":"traceutil/trace.go:171","msg":"trace[1196255195] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2063; }","duration":"101.182091ms","start":"2026-05-09T12:56:33.323426Z","end":"2026-05-09T12:56:33.424608Z","steps":["trace[1196255195] 'agreement among raft nodes before linearized reading' (duration: 100.964265ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:57:01.41013Z","caller":"traceutil/trace.go:171","msg":"trace[1877484993] linearizableReadLoop","detail":"{readStateIndex:2299; appliedIndex:2298; }","duration":"143.759658ms","start":"2026-05-09T12:57:01.266344Z","end":"2026-05-09T12:57:01.410103Z","steps":["trace[1877484993] 'read index received' (duration: 143.637435ms)","trace[1877484993] 'applied index is now lower than readState.Index' (duration: 120.963µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:57:01.41017Z","caller":"traceutil/trace.go:171","msg":"trace[401401352] transaction","detail":"{read_only:false; response_revision:2220; number_of_response:1; }","duration":"203.732097ms","start":"2026-05-09T12:57:01.206414Z","end":"2026-05-09T12:57:01.410146Z","steps":["trace[401401352] 'process raft request' (duration: 203.520801ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:57:01.410304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.942564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:57:01.410395Z","caller":"traceutil/trace.go:171","msg":"trace[2091235937] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2220; }","duration":"144.080798ms","start":"2026-05-09T12:57:01.266291Z","end":"2026-05-09T12:57:01.410372Z","steps":["trace[2091235937] 'agreement among raft nodes before linearized reading' (duration: 143.927723ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:57:13.595099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.071158ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-09T12:57:13.595209Z","caller":"traceutil/trace.go:171","msg":"trace[1202676580] linearizableReadLoop","detail":"{readStateIndex:2367; appliedIndex:2366; }","duration":"104.025848ms","start":"2026-05-09T12:57:13.491165Z","end":"2026-05-09T12:57:13.595191Z","steps":["trace[1202676580] 'read index received' (duration: 54.451µs)","trace[1202676580] 'applied index is now lower than readState.Index' (duration: 103.969817ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T12:57:13.595685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.510001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-09T12:57:13.595748Z","caller":"traceutil/trace.go:171","msg":"trace[571468438] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2284; }","duration":"104.590554ms","start":"2026-05-09T12:57:13.491143Z","end":"2026-05-09T12:57:13.595733Z","steps":["trace[571468438] 'agreement among raft nodes before linearized reading' (duration: 104.10517ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:58:36.991014Z","caller":"traceutil/trace.go:171","msg":"trace[1885987893] linearizableReadLoop","detail":"{readStateIndex:3040; appliedIndex:3039; }","duration":"124.232532ms","start":"2026-05-09T12:58:36.866752Z","end":"2026-05-09T12:58:36.990985Z","steps":["trace[1885987893] 'read index received' (duration: 124.080457ms)","trace[1885987893] 'applied index is now lower than readState.Index' (duration: 150.685µs)"],"step_count":2} {"level":"warn","ts":"2026-05-09T12:58:36.991292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.509579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak\" ","response":"range_response_count:1 size:1317"} {"level":"info","ts":"2026-05-09T12:58:36.991334Z","caller":"traceutil/trace.go:171","msg":"trace[1698137647] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak; range_end:; response_count:1; response_revision:2934; }","duration":"124.603942ms","start":"2026-05-09T12:58:36.866719Z","end":"2026-05-09T12:58:36.991323Z","steps":["trace[1698137647] 'agreement among raft nodes before linearized reading' (duration: 124.384936ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:58:36.99171Z","caller":"traceutil/trace.go:171","msg":"trace[1263029769] transaction","detail":"{read_only:false; response_revision:2934; number_of_response:1; }","duration":"126.534004ms","start":"2026-05-09T12:58:36.865164Z","end":"2026-05-09T12:58:36.991698Z","steps":["trace[1263029769] 'process raft request' (duration: 125.651979ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:01:02.622805Z","caller":"traceutil/trace.go:171","msg":"trace[1348609323] transaction","detail":"{read_only:false; response_revision:3898; number_of_response:1; }","duration":"154.86499ms","start":"2026-05-09T13:01:02.467914Z","end":"2026-05-09T13:01:02.622779Z","steps":["trace[1348609323] 'process raft request' (duration: 154.703485ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:01:02.712862Z","caller":"traceutil/trace.go:171","msg":"trace[1682345065] transaction","detail":"{read_only:false; response_revision:3899; number_of_response:1; }","duration":"240.787688ms","start":"2026-05-09T13:01:02.472048Z","end":"2026-05-09T13:01:02.712835Z","steps":["trace[1682345065] 'process raft request' (duration: 240.591703ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:01:02.71302Z","caller":"traceutil/trace.go:171","msg":"trace[1035295129] transaction","detail":"{read_only:false; response_revision:3900; number_of_response:1; }","duration":"232.771078ms","start":"2026-05-09T13:01:02.480218Z","end":"2026-05-09T13:01:02.712989Z","steps":["trace[1035295129] 'process raft request' (duration: 232.575063ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:02:38.072053Z","caller":"traceutil/trace.go:171","msg":"trace[79364735] transaction","detail":"{read_only:false; response_revision:5321; number_of_response:1; }","duration":"217.984954ms","start":"2026-05-09T13:02:37.854044Z","end":"2026-05-09T13:02:38.072029Z","steps":["trace[79364735] 'process raft request' (duration: 168.428246ms)","trace[79364735] 'compare' (duration: 49.288681ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T13:02:38.072195Z","caller":"traceutil/trace.go:171","msg":"trace[1393262057] transaction","detail":"{read_only:false; response_revision:5322; number_of_response:1; }","duration":"217.390526ms","start":"2026-05-09T13:02:37.854761Z","end":"2026-05-09T13:02:38.072151Z","steps":["trace[1393262057] 'process raft request' (duration: 217.189471ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:02:38.07232Z","caller":"traceutil/trace.go:171","msg":"trace[494877633] transaction","detail":"{read_only:false; response_revision:5323; number_of_response:1; }","duration":"216.801601ms","start":"2026-05-09T13:02:37.85551Z","end":"2026-05-09T13:02:38.072312Z","steps":["trace[494877633] 'process raft request' (duration: 216.554424ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:02:38.072282Z","caller":"traceutil/trace.go:171","msg":"trace[1801108602] transaction","detail":"{read_only:false; response_revision:5324; number_of_response:1; }","duration":"213.039928ms","start":"2026-05-09T13:02:37.859208Z","end":"2026-05-09T13:02:38.072248Z","steps":["trace[1801108602] 'process raft request' (duration: 212.967986ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:02:46.069692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.555663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-05-09T13:02:46.069788Z","caller":"traceutil/trace.go:171","msg":"trace[1876781140] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5488; }","duration":"105.671796ms","start":"2026-05-09T13:02:45.964097Z","end":"2026-05-09T13:02:46.069768Z","steps":["trace[1876781140] 'range keys from in-memory index tree' (duration: 105.339036ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:03:55.196339Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3033} {"level":"info","ts":"2026-05-09T13:03:55.285696Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3033,"took":"87.49723ms","hash":471316112,"current-db-size-bytes":57737216,"current-db-size":"58 MB","current-db-size-in-use-bytes":31637504,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-05-09T13:03:55.285799Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":471316112,"revision":3033,"compact-revision":-1} {"level":"info","ts":"2026-05-09T13:08:48.419455Z","caller":"traceutil/trace.go:171","msg":"trace[1630396916] linearizableReadLoop","detail":"{readStateIndex:8583; appliedIndex:8582; }","duration":"174.205641ms","start":"2026-05-09T13:08:48.245223Z","end":"2026-05-09T13:08:48.419429Z","steps":["trace[1630396916] 'read index received' (duration: 174.139899ms)","trace[1630396916] 'applied index is now lower than readState.Index' (duration: 63.962µs)"],"step_count":2} {"level":"warn","ts":"2026-05-09T13:08:48.419871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.634903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-09T13:08:48.419909Z","caller":"traceutil/trace.go:171","msg":"trace[112117355] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8297; }","duration":"174.708165ms","start":"2026-05-09T13:08:48.245189Z","end":"2026-05-09T13:08:48.419897Z","steps":["trace[112117355] 'agreement among raft nodes before linearized reading' (duration: 174.548751ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:08:48.444527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.943766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T13:08:48.444609Z","caller":"traceutil/trace.go:171","msg":"trace[718311292] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8300; }","duration":"181.05867ms","start":"2026-05-09T13:08:48.263532Z","end":"2026-05-09T13:08:48.44459Z","steps":["trace[718311292] 'agreement among raft nodes before linearized reading' (duration: 180.897705ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:08:48.444913Z","caller":"traceutil/trace.go:171","msg":"trace[236853087] transaction","detail":"{read_only:false; response_revision:8298; number_of_response:1; }","duration":"149.683669ms","start":"2026-05-09T13:08:48.295215Z","end":"2026-05-09T13:08:48.444899Z","steps":["trace[236853087] 'process raft request' (duration: 149.011701ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:08:48.617912Z","caller":"traceutil/trace.go:171","msg":"trace[893471424] linearizableReadLoop","detail":"{readStateIndex:8588; appliedIndex:8586; }","duration":"172.007721ms","start":"2026-05-09T13:08:48.445881Z","end":"2026-05-09T13:08:48.617889Z","steps":["trace[893471424] 'read index received' (duration: 134.958984ms)","trace[893471424] 'applied index is now lower than readState.Index' (duration: 37.047847ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T13:08:48.618113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.200807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T13:08:48.618175Z","caller":"traceutil/trace.go:171","msg":"trace[1690207730] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8302; }","duration":"172.278219ms","start":"2026-05-09T13:08:48.445878Z","end":"2026-05-09T13:08:48.618156Z","steps":["trace[1690207730] 'agreement among raft nodes before linearized reading' (duration: 172.128335ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:08:48.61848Z","caller":"traceutil/trace.go:171","msg":"trace[239343894] transaction","detail":"{read_only:false; response_revision:8301; number_of_response:1; }","duration":"197.629945ms","start":"2026-05-09T13:08:48.420838Z","end":"2026-05-09T13:08:48.618468Z","steps":["trace[239343894] 'process raft request' (duration: 160.127415ms)","trace[239343894] 'compare' (duration: 36.722259ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T13:08:48.618744Z","caller":"traceutil/trace.go:171","msg":"trace[694415866] transaction","detail":"{read_only:false; response_revision:8302; number_of_response:1; }","duration":"195.609509ms","start":"2026-05-09T13:08:48.423124Z","end":"2026-05-09T13:08:48.618733Z","steps":["trace[694415866] 'process raft request' (duration: 194.706995ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:08:55.202877Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6137} {"level":"info","ts":"2026-05-09T13:08:55.296614Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6137,"took":"91.744708ms","hash":2124105268,"current-db-size-bytes":57737216,"current-db-size":"58 MB","current-db-size-in-use-bytes":23416832,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-05-09T13:08:55.296675Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2124105268,"revision":6137,"compact-revision":3033} {"level":"info","ts":"2026-05-09T13:09:00.965606Z","caller":"traceutil/trace.go:171","msg":"trace[1090171361] linearizableReadLoop","detail":"{readStateIndex:8656; appliedIndex:8655; }","duration":"262.133494ms","start":"2026-05-09T13:09:00.703446Z","end":"2026-05-09T13:09:00.96558Z","steps":["trace[1090171361] 'read index received' (duration: 261.98679ms)","trace[1090171361] 'applied index is now lower than readState.Index' (duration: 145.434µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T13:09:00.965726Z","caller":"traceutil/trace.go:171","msg":"trace[1860456208] transaction","detail":"{read_only:false; response_revision:8366; number_of_response:1; }","duration":"265.99293ms","start":"2026-05-09T13:09:00.699674Z","end":"2026-05-09T13:09:00.965667Z","steps":["trace[1860456208] 'process raft request' (duration: 265.737883ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:09:00.965898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.429652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-q48cj\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-05-09T13:09:00.965953Z","caller":"traceutil/trace.go:171","msg":"trace[735719513] range","detail":"{range_begin:/registry/pods/openstack/keepalived-q48cj; range_end:; response_count:1; response_revision:8366; }","duration":"262.530825ms","start":"2026-05-09T13:09:00.703405Z","end":"2026-05-09T13:09:00.965936Z","steps":["trace[735719513] 'agreement among raft nodes before linearized reading' (duration: 262.309339ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:09:01.029916Z","caller":"traceutil/trace.go:171","msg":"trace[243436471] transaction","detail":"{read_only:false; response_revision:8367; number_of_response:1; }","duration":"198.059046ms","start":"2026-05-09T13:09:00.831811Z","end":"2026-05-09T13:09:01.02987Z","steps":["trace[243436471] 'process raft request' (duration: 176.754742ms)","trace[243436471] 'compare' (duration: 20.932604ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T13:09:48.814865Z","caller":"traceutil/trace.go:171","msg":"trace[399744682] transaction","detail":"{read_only:false; response_revision:8720; number_of_response:1; }","duration":"213.466088ms","start":"2026-05-09T13:09:48.601358Z","end":"2026-05-09T13:09:48.814824Z","steps":["trace[399744682] 'process raft request' (duration: 213.210291ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:09:48.861929Z","caller":"traceutil/trace.go:171","msg":"trace[430372989] transaction","detail":"{read_only:false; response_revision:8721; number_of_response:1; }","duration":"109.698981ms","start":"2026-05-09T13:09:48.752203Z","end":"2026-05-09T13:09:48.861902Z","steps":["trace[430372989] 'process raft request' (duration: 109.499005ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:10:32.553115Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002521.wal"} {"level":"info","ts":"2026-05-09T13:11:30.534476Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"331455d6226d3423","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-09T13:11:30.539379Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-05-09T13:11:30.539451Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-05-09T13:13:55.210954Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8339} {"level":"info","ts":"2026-05-09T13:13:55.289053Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8339,"took":"75.560479ms","hash":1019729070,"current-db-size-bytes":57737216,"current-db-size":"58 MB","current-db-size-in-use-bytes":26050560,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-05-09T13:13:55.289141Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1019729070,"revision":8339,"compact-revision":6137} {"level":"info","ts":"2026-05-09T13:18:55.216653Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10823} {"level":"info","ts":"2026-05-09T13:18:55.305869Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10823,"took":"85.349855ms","hash":3251546169,"current-db-size-bytes":57737216,"current-db-size":"58 MB","current-db-size-in-use-bytes":27738112,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-05-09T13:18:55.305949Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3251546169,"revision":10823,"compact-revision":8339} {"level":"warn","ts":"2026-05-09T13:21:00.928417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.229488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-09T13:21:00.928512Z","caller":"traceutil/trace.go:171","msg":"trace[250953545] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:13818; }","duration":"201.368702ms","start":"2026-05-09T13:21:00.727124Z","end":"2026-05-09T13:21:00.928492Z","steps":["trace[250953545] 'count revisions from in-memory index tree' (duration: 201.164526ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:21:00.928451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.515443ms","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-05-09T13:21:00.928595Z","caller":"traceutil/trace.go:171","msg":"trace[2140533444] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:13818; }","duration":"206.708238ms","start":"2026-05-09T13:21:00.721857Z","end":"2026-05-09T13:21:00.928565Z","steps":["trace[2140533444] 'range keys from in-memory index tree' (duration: 206.262077ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:21:16.302382Z","caller":"traceutil/trace.go:171","msg":"trace[845051527] transaction","detail":"{read_only:false; response_revision:13915; number_of_response:1; }","duration":"244.434549ms","start":"2026-05-09T13:21:16.057922Z","end":"2026-05-09T13:21:16.302356Z","steps":["trace[845051527] 'process raft request' (duration: 244.266255ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:21:37.708202Z","caller":"traceutil/trace.go:171","msg":"trace[1526859344] transaction","detail":"{read_only:false; response_revision:14222; number_of_response:1; }","duration":"115.028442ms","start":"2026-05-09T13:21:37.593148Z","end":"2026-05-09T13:21:37.708177Z","steps":["trace[1526859344] 'process raft request' (duration: 114.863688ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:23:55.222326Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12994} {"level":"info","ts":"2026-05-09T13:23:55.301657Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12994,"took":"76.46171ms","hash":2250463548,"current-db-size-bytes":57737216,"current-db-size":"58 MB","current-db-size-in-use-bytes":30433280,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-09T13:23:55.301731Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2250463548,"revision":12994,"compact-revision":10823} {"level":"info","ts":"2026-05-09T13:25:55.181922Z","caller":"traceutil/trace.go:171","msg":"trace[388389841] transaction","detail":"{read_only:false; response_revision:16447; number_of_response:1; }","duration":"110.770437ms","start":"2026-05-09T13:25:55.071132Z","end":"2026-05-09T13:25:55.181902Z","steps":["trace[388389841] 'process raft request' (duration: 110.652884ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:28:53.024772Z","caller":"traceutil/trace.go:171","msg":"trace[1290793435] transaction","detail":"{read_only:false; response_revision:17623; number_of_response:1; }","duration":"188.704959ms","start":"2026-05-09T13:28:52.836035Z","end":"2026-05-09T13:28:53.02474Z","steps":["trace[1290793435] 'process raft request' (duration: 188.505934ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:28:53.300958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.771204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-05-09T13:28:53.301079Z","caller":"traceutil/trace.go:171","msg":"trace[1346864754] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:17623; }","duration":"220.95558ms","start":"2026-05-09T13:28:53.080098Z","end":"2026-05-09T13:28:53.301053Z","steps":["trace[1346864754] 'range keys from in-memory index tree' (duration: 220.6016ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:28:53.301424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.569242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-05-09T13:28:53.301473Z","caller":"traceutil/trace.go:171","msg":"trace[430075101] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:17623; }","duration":"219.635903ms","start":"2026-05-09T13:28:53.081821Z","end":"2026-05-09T13:28:53.301457Z","steps":["trace[430075101] 'range keys from in-memory index tree' (duration: 219.478469ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:28:53.301874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.680961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:28:53.301925Z","caller":"traceutil/trace.go:171","msg":"trace[2027204478] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:17623; }","duration":"209.733533ms","start":"2026-05-09T13:28:53.092175Z","end":"2026-05-09T13:28:53.301908Z","steps":["trace[2027204478] 'count revisions from in-memory index tree' (duration: 209.598889ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:28:53.523072Z","caller":"traceutil/trace.go:171","msg":"trace[1781334991] linearizableReadLoop","detail":"{readStateIndex:18217; appliedIndex:18215; }","duration":"256.508699ms","start":"2026-05-09T13:28:53.266532Z","end":"2026-05-09T13:28:53.523041Z","steps":["trace[1781334991] 'read index received' (duration: 21.581169ms)","trace[1781334991] 'applied index is now lower than readState.Index' (duration: 234.92635ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T13:28:53.523271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.709774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:28:53.523496Z","caller":"traceutil/trace.go:171","msg":"trace[464367928] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17625; }","duration":"256.979552ms","start":"2026-05-09T13:28:53.266492Z","end":"2026-05-09T13:28:53.523472Z","steps":["trace[464367928] 'agreement among raft nodes before linearized reading' (duration: 256.687974ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:28:53.523289Z","caller":"traceutil/trace.go:171","msg":"trace[2050940025] transaction","detail":"{read_only:false; response_revision:17625; number_of_response:1; }","duration":"281.314435ms","start":"2026-05-09T13:28:53.241869Z","end":"2026-05-09T13:28:53.523184Z","steps":["trace[2050940025] 'process raft request' (duration: 243.600127ms)","trace[2050940025] 'compare' (duration: 37.378389ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T13:28:53.550712Z","caller":"traceutil/trace.go:171","msg":"trace[333701844] transaction","detail":"{read_only:false; response_revision:17626; number_of_response:1; }","duration":"242.657981ms","start":"2026-05-09T13:28:53.30803Z","end":"2026-05-09T13:28:53.550688Z","steps":["trace[333701844] 'process raft request' (duration: 242.023604ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:28:53.550712Z","caller":"traceutil/trace.go:171","msg":"trace[2145320093] transaction","detail":"{read_only:false; response_revision:17627; number_of_response:1; }","duration":"240.871243ms","start":"2026-05-09T13:28:53.309805Z","end":"2026-05-09T13:28:53.550676Z","steps":["trace[2145320093] 'process raft request' (duration: 240.75905ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:28:53.551066Z","caller":"traceutil/trace.go:171","msg":"trace[566804309] transaction","detail":"{read_only:false; response_revision:17628; number_of_response:1; }","duration":"174.943283ms","start":"2026-05-09T13:28:53.376065Z","end":"2026-05-09T13:28:53.551008Z","steps":["trace[566804309] 'process raft request' (duration: 174.565533ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:28:53.551112Z","caller":"traceutil/trace.go:171","msg":"trace[376455599] transaction","detail":"{read_only:false; response_revision:17629; number_of_response:1; }","duration":"174.417309ms","start":"2026-05-09T13:28:53.376664Z","end":"2026-05-09T13:28:53.551081Z","steps":["trace[376455599] 'process raft request' (duration: 174.234624ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:28:53.551372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.576393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-6bgtk\" ","response":"range_response_count:1 size:22097"} {"level":"warn","ts":"2026-05-09T13:28:53.551411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.823528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-09T13:28:53.551614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.020191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-05-09T13:28:53.551631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.978888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-09T13:28:53.551694Z","caller":"traceutil/trace.go:171","msg":"trace[1939565089] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:17629; }","duration":"217.118064ms","start":"2026-05-09T13:28:53.334541Z","end":"2026-05-09T13:28:53.551659Z","steps":["trace[1939565089] 'agreement among raft nodes before linearized reading' (duration: 216.853787ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:28:53.551478Z","caller":"traceutil/trace.go:171","msg":"trace[1820119377] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-6bgtk; range_end:; response_count:1; response_revision:17629; }","duration":"178.770629ms","start":"2026-05-09T13:28:53.372685Z","end":"2026-05-09T13:28:53.551455Z","steps":["trace[1820119377] 'agreement among raft nodes before linearized reading' (duration: 178.4547ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:28:53.551557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.39395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-05-09T13:28:53.551825Z","caller":"traceutil/trace.go:171","msg":"trace[173450702] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:17629; }","duration":"262.727079ms","start":"2026-05-09T13:28:53.289084Z","end":"2026-05-09T13:28:53.551811Z","steps":["trace[173450702] 'agreement among raft nodes before linearized reading' (duration: 262.287897ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:28:53.551757Z","caller":"traceutil/trace.go:171","msg":"trace[1264508169] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:17629; }","duration":"231.126726ms","start":"2026-05-09T13:28:53.320497Z","end":"2026-05-09T13:28:53.551624Z","steps":["trace[1264508169] 'agreement among raft nodes before linearized reading' (duration: 230.776407ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:28:53.551719Z","caller":"traceutil/trace.go:171","msg":"trace[2132642668] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:17629; }","duration":"218.128282ms","start":"2026-05-09T13:28:53.333577Z","end":"2026-05-09T13:28:53.551705Z","steps":["trace[2132642668] 'agreement among raft nodes before linearized reading' (duration: 217.840825ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:28:55.229241Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15358} {"level":"info","ts":"2026-05-09T13:28:55.327321Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15358,"took":"93.051629ms","hash":3366657940,"current-db-size-bytes":57737216,"current-db-size":"58 MB","current-db-size-in-use-bytes":31838208,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-05-09T13:28:55.327389Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3366657940,"revision":15358,"compact-revision":12994} {"level":"info","ts":"2026-05-09T13:32:23.53842Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"331455d6226d3423","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-09T13:32:23.549054Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-05-09T13:32:23.54918Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-05-09T13:33:55.238571Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17641} {"level":"info","ts":"2026-05-09T13:33:55.340543Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17641,"took":"99.294548ms","hash":1809001988,"current-db-size-bytes":57737216,"current-db-size":"58 MB","current-db-size-in-use-bytes":33832960,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-05-09T13:33:55.340599Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1809001988,"revision":17641,"compact-revision":15358} {"level":"info","ts":"2026-05-09T13:34:51.57124Z","caller":"traceutil/trace.go:171","msg":"trace[400799473] transaction","detail":"{read_only:false; response_revision:20371; number_of_response:1; }","duration":"150.632868ms","start":"2026-05-09T13:34:51.420574Z","end":"2026-05-09T13:34:51.571207Z","steps":["trace[400799473] 'process raft request' (duration: 150.565847ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:34:51.571431Z","caller":"traceutil/trace.go:171","msg":"trace[1212802012] transaction","detail":"{read_only:false; response_revision:20370; number_of_response:1; }","duration":"152.806247ms","start":"2026-05-09T13:34:51.418572Z","end":"2026-05-09T13:34:51.571378Z","steps":["trace[1212802012] 'process raft request' (duration: 102.479985ms)","trace[1212802012] 'compare' (duration: 49.916621ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T13:34:51.571429Z","caller":"traceutil/trace.go:171","msg":"trace[1437774395] linearizableReadLoop","detail":"{readStateIndex:21056; appliedIndex:21055; }","duration":"152.052026ms","start":"2026-05-09T13:34:51.419342Z","end":"2026-05-09T13:34:51.571394Z","steps":["trace[1437774395] 'read index received' (duration: 101.711384ms)","trace[1437774395] 'applied index is now lower than readState.Index' (duration: 50.337842ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T13:34:51.571694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.322944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-09T13:34:51.571792Z","caller":"traceutil/trace.go:171","msg":"trace[771814417] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20371; }","duration":"152.463948ms","start":"2026-05-09T13:34:51.419308Z","end":"2026-05-09T13:34:51.571772Z","steps":["trace[771814417] 'agreement among raft nodes before linearized reading' (duration: 152.18885ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:34:51.571926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.531863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-05-09T13:34:51.572091Z","caller":"traceutil/trace.go:171","msg":"trace[901408215] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20371; }","duration":"151.752639ms","start":"2026-05-09T13:34:51.420315Z","end":"2026-05-09T13:34:51.572068Z","steps":["trace[901408215] 'agreement among raft nodes before linearized reading' (duration: 151.353138ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:35:03.681924Z","caller":"traceutil/trace.go:171","msg":"trace[1532811383] transaction","detail":"{read_only:false; response_revision:20445; number_of_response:1; }","duration":"243.066969ms","start":"2026-05-09T13:35:03.438818Z","end":"2026-05-09T13:35:03.681885Z","steps":["trace[1532811383] 'process raft request' (duration: 242.648188ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:35:03.823486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.06571ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-09T13:35:03.823804Z","caller":"traceutil/trace.go:171","msg":"trace[1009191241] linearizableReadLoop","detail":"{readStateIndex:21134; appliedIndex:21132; }","duration":"205.231867ms","start":"2026-05-09T13:35:03.618414Z","end":"2026-05-09T13:35:03.823646Z","steps":["trace[1009191241] 'read index received' (duration: 63.07088ms)","trace[1009191241] 'applied index is now lower than readState.Index' (duration: 142.158487ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T13:35:03.824018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.588907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-05-09T13:35:03.824106Z","caller":"traceutil/trace.go:171","msg":"trace[185392182] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:20445; }","duration":"205.73481ms","start":"2026-05-09T13:35:03.618348Z","end":"2026-05-09T13:35:03.824083Z","steps":["trace[185392182] 'agreement among raft nodes before linearized reading' (duration: 205.461223ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:35:03.824295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.176465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-05-09T13:35:03.824568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.951609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-05-09T13:35:03.824716Z","caller":"traceutil/trace.go:171","msg":"trace[34267516] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20445; }","duration":"172.130094ms","start":"2026-05-09T13:35:03.652537Z","end":"2026-05-09T13:35:03.824667Z","steps":["trace[34267516] 'agreement among raft nodes before linearized reading' (duration: 171.736374ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:35:03.82462Z","caller":"traceutil/trace.go:171","msg":"trace[445444278] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20445; }","duration":"198.601386ms","start":"2026-05-09T13:35:03.626003Z","end":"2026-05-09T13:35:03.824604Z","steps":["trace[445444278] 'agreement among raft nodes before linearized reading' (duration: 197.98115ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:35:03.824462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.323497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-09T13:35:03.82501Z","caller":"traceutil/trace.go:171","msg":"trace[521106096] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20445; }","duration":"162.907792ms","start":"2026-05-09T13:35:03.662051Z","end":"2026-05-09T13:35:03.824959Z","steps":["trace[521106096] 'agreement among raft nodes before linearized reading' (duration: 162.063639ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:35:03.972404Z","caller":"traceutil/trace.go:171","msg":"trace[987034121] transaction","detail":"{read_only:false; response_revision:20446; number_of_response:1; }","duration":"142.9874ms","start":"2026-05-09T13:35:03.82939Z","end":"2026-05-09T13:35:03.972378Z","steps":["trace[987034121] 'process raft request' (duration: 142.762834ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:35:03.979199Z","caller":"traceutil/trace.go:171","msg":"trace[1523286871] transaction","detail":"{read_only:false; response_revision:20447; number_of_response:1; }","duration":"149.636701ms","start":"2026-05-09T13:35:03.829534Z","end":"2026-05-09T13:35:03.97917Z","steps":["trace[1523286871] 'process raft request' (duration: 149.316932ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:35:03.979182Z","caller":"traceutil/trace.go:171","msg":"trace[1335007049] transaction","detail":"{read_only:false; response_revision:20448; number_of_response:1; }","duration":"148.774547ms","start":"2026-05-09T13:35:03.830381Z","end":"2026-05-09T13:35:03.979155Z","steps":["trace[1335007049] 'process raft request' (duration: 148.682495ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:35:03.979329Z","caller":"traceutil/trace.go:171","msg":"trace[1242898080] transaction","detail":"{read_only:false; response_revision:20449; number_of_response:1; }","duration":"148.782997ms","start":"2026-05-09T13:35:03.830525Z","end":"2026-05-09T13:35:03.979308Z","steps":["trace[1242898080] 'process raft request' (duration: 148.593172ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:38:55.247873Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20084} {"level":"info","ts":"2026-05-09T13:38:55.368354Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20084,"took":"114.348337ms","hash":1425488484,"current-db-size-bytes":57737216,"current-db-size":"58 MB","current-db-size-in-use-bytes":39628800,"current-db-size-in-use":"40 MB"} {"level":"info","ts":"2026-05-09T13:38:55.368447Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1425488484,"revision":20084,"compact-revision":17641} {"level":"info","ts":"2026-05-09T13:38:57.918587Z","caller":"traceutil/trace.go:171","msg":"trace[701614377] transaction","detail":"{read_only:false; response_revision:22867; number_of_response:1; }","duration":"205.31037ms","start":"2026-05-09T13:38:57.713246Z","end":"2026-05-09T13:38:57.918556Z","steps":["trace[701614377] 'process raft request' (duration: 205.153556ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:38:57.91929Z","caller":"traceutil/trace.go:171","msg":"trace[269229726] linearizableReadLoop","detail":"{readStateIndex:23631; appliedIndex:23628; }","duration":"101.22459ms","start":"2026-05-09T13:38:57.81804Z","end":"2026-05-09T13:38:57.919265Z","steps":["trace[269229726] 'read index received' (duration: 100.276605ms)","trace[269229726] 'applied index is now lower than readState.Index' (duration: 946.955µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T13:38:57.919442Z","caller":"traceutil/trace.go:171","msg":"trace[431675522] transaction","detail":"{read_only:false; response_revision:22869; number_of_response:1; }","duration":"195.951944ms","start":"2026-05-09T13:38:57.723466Z","end":"2026-05-09T13:38:57.919418Z","steps":["trace[431675522] 'process raft request' (duration: 195.741229ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:38:57.919544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.473667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-09T13:38:57.919589Z","caller":"traceutil/trace.go:171","msg":"trace[567763153] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:22869; }","duration":"101.59727ms","start":"2026-05-09T13:38:57.817979Z","end":"2026-05-09T13:38:57.919576Z","steps":["trace[567763153] 'agreement among raft nodes before linearized reading' (duration: 101.387255ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:38:57.920487Z","caller":"traceutil/trace.go:171","msg":"trace[689878324] transaction","detail":"{read_only:false; response_revision:22868; number_of_response:1; }","duration":"197.183227ms","start":"2026-05-09T13:38:57.723237Z","end":"2026-05-09T13:38:57.92042Z","steps":["trace[689878324] 'process raft request' (duration: 195.81513ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:38:58.070769Z","caller":"traceutil/trace.go:171","msg":"trace[729796461] transaction","detail":"{read_only:false; response_revision:22870; number_of_response:1; }","duration":"106.968147ms","start":"2026-05-09T13:38:57.96377Z","end":"2026-05-09T13:38:58.070738Z","steps":["trace[729796461] 'process raft request' (duration: 106.754471ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:42:18.648497Z","caller":"traceutil/trace.go:171","msg":"trace[1187595915] transaction","detail":"{read_only:false; response_revision:24937; number_of_response:1; }","duration":"123.362306ms","start":"2026-05-09T13:42:18.525097Z","end":"2026-05-09T13:42:18.648459Z","steps":["trace[1187595915] 'process raft request' (duration: 122.80117ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:42:24.068735Z","caller":"traceutil/trace.go:171","msg":"trace[1114436426] transaction","detail":"{read_only:false; response_revision:24981; number_of_response:1; }","duration":"154.266358ms","start":"2026-05-09T13:42:23.914447Z","end":"2026-05-09T13:42:24.068713Z","steps":["trace[1114436426] 'process raft request' (duration: 154.093153ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:42:24.371378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.510932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-09T13:42:24.371473Z","caller":"traceutil/trace.go:171","msg":"trace[1099356257] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24981; }","duration":"192.666676ms","start":"2026-05-09T13:42:24.178788Z","end":"2026-05-09T13:42:24.371454Z","steps":["trace[1099356257] 'range keys from in-memory index tree' (duration: 192.313976ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:42:24.371377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.922605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-05-09T13:42:24.371576Z","caller":"traceutil/trace.go:171","msg":"trace[333004749] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24981; }","duration":"185.180333ms","start":"2026-05-09T13:42:24.186376Z","end":"2026-05-09T13:42:24.371557Z","steps":["trace[333004749] 'range keys from in-memory index tree' (duration: 184.703499ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:42:24.498522Z","caller":"traceutil/trace.go:171","msg":"trace[525423264] linearizableReadLoop","detail":"{readStateIndex:25798; appliedIndex:25797; }","duration":"231.839165ms","start":"2026-05-09T13:42:24.26665Z","end":"2026-05-09T13:42:24.498489Z","steps":["trace[525423264] 'read index received' (duration: 231.64514ms)","trace[525423264] 'applied index is now lower than readState.Index' (duration: 192.505µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T13:42:24.498622Z","caller":"traceutil/trace.go:171","msg":"trace[2127850180] transaction","detail":"{read_only:false; response_revision:24982; number_of_response:1; }","duration":"252.221341ms","start":"2026-05-09T13:42:24.246369Z","end":"2026-05-09T13:42:24.49859Z","steps":["trace[2127850180] 'process raft request' (duration: 251.882942ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:42:24.498744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.087181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:42:24.498778Z","caller":"traceutil/trace.go:171","msg":"trace[1826422228] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24982; }","duration":"232.162954ms","start":"2026-05-09T13:42:24.266609Z","end":"2026-05-09T13:42:24.498772Z","steps":["trace[1826422228] 'agreement among raft nodes before linearized reading' (duration: 232.079211ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:42:24.512658Z","caller":"traceutil/trace.go:171","msg":"trace[530047172] transaction","detail":"{read_only:false; response_revision:24983; number_of_response:1; }","duration":"136.726881ms","start":"2026-05-09T13:42:24.375901Z","end":"2026-05-09T13:42:24.512628Z","steps":["trace[530047172] 'process raft request' (duration: 136.230477ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:42:24.513034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.676673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-05-09T13:42:24.513074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.932781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:42:24.513103Z","caller":"traceutil/trace.go:171","msg":"trace[43539594] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24984; }","duration":"219.807586ms","start":"2026-05-09T13:42:24.29328Z","end":"2026-05-09T13:42:24.513087Z","steps":["trace[43539594] 'agreement among raft nodes before linearized reading' (duration: 219.545139ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:42:24.513145Z","caller":"traceutil/trace.go:171","msg":"trace[866639551] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:24984; }","duration":"139.071974ms","start":"2026-05-09T13:42:24.374054Z","end":"2026-05-09T13:42:24.513126Z","steps":["trace[866639551] 'agreement among raft nodes before linearized reading' (duration: 138.93617ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:42:24.513252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.958923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-09T13:42:24.513276Z","caller":"traceutil/trace.go:171","msg":"trace[597360869] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24984; }","duration":"218.996904ms","start":"2026-05-09T13:42:24.294272Z","end":"2026-05-09T13:42:24.513269Z","steps":["trace[597360869] 'agreement among raft nodes before linearized reading' (duration: 218.936782ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:42:24.513345Z","caller":"traceutil/trace.go:171","msg":"trace[1808782653] transaction","detail":"{read_only:false; response_revision:24984; number_of_response:1; }","duration":"136.942246ms","start":"2026-05-09T13:42:24.376394Z","end":"2026-05-09T13:42:24.513337Z","steps":["trace[1808782653] 'process raft request' (duration: 135.922628ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:42:29.13455Z","caller":"traceutil/trace.go:171","msg":"trace[1675244806] transaction","detail":"{read_only:false; response_revision:25022; number_of_response:1; }","duration":"152.614304ms","start":"2026-05-09T13:42:28.98191Z","end":"2026-05-09T13:42:29.134525Z","steps":["trace[1675244806] 'process raft request' (duration: 152.445989ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:42:30.423358Z","caller":"traceutil/trace.go:171","msg":"trace[951750466] linearizableReadLoop","detail":"{readStateIndex:25844; appliedIndex:25842; }","duration":"263.105758ms","start":"2026-05-09T13:42:30.16021Z","end":"2026-05-09T13:42:30.423316Z","steps":["trace[951750466] 'read index received' (duration: 8.170823ms)","trace[951750466] 'applied index is now lower than readState.Index' (duration: 254.933615ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T13:42:30.42344Z","caller":"traceutil/trace.go:171","msg":"trace[1026468725] transaction","detail":"{read_only:false; response_revision:25027; number_of_response:1; }","duration":"320.181055ms","start":"2026-05-09T13:42:30.103175Z","end":"2026-05-09T13:42:30.423356Z","steps":["trace[1026468725] 'process raft request' (duration: 284.134652ms)","trace[1026468725] 'compare' (duration: 35.619331ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T13:42:30.423519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.288022ms","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:6"} {"level":"info","ts":"2026-05-09T13:42:30.423575Z","caller":"traceutil/trace.go:171","msg":"trace[1745157799] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:25027; }","duration":"263.416916ms","start":"2026-05-09T13:42:30.16014Z","end":"2026-05-09T13:42:30.423557Z","steps":["trace[1745157799] 'agreement among raft nodes before linearized reading' (duration: 263.313493ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:42:30.423682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T13:42:30.103157Z","time spent":"320.380581ms","remote":"127.0.0.1:33560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":626,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T13:42:30.423668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.359908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" ","response":"range_response_count:1 size:539"} {"level":"info","ts":"2026-05-09T13:42:30.423793Z","caller":"traceutil/trace.go:171","msg":"trace[198187814] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium-operator; range_end:; response_count:1; response_revision:25027; }","duration":"203.547603ms","start":"2026-05-09T13:42:30.220213Z","end":"2026-05-09T13:42:30.42376Z","steps":["trace[198187814] 'agreement among raft nodes before linearized reading' (duration: 203.294146ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:42:30.42418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.482538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:42:30.424383Z","caller":"traceutil/trace.go:171","msg":"trace[1111598066] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25027; }","duration":"160.635972ms","start":"2026-05-09T13:42:30.263625Z","end":"2026-05-09T13:42:30.424261Z","steps":["trace[1111598066] 'agreement among raft nodes before linearized reading' (duration: 160.106678ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:42:30.627328Z","caller":"traceutil/trace.go:171","msg":"trace[1588027747] transaction","detail":"{read_only:false; response_revision:25028; number_of_response:1; }","duration":"110.407612ms","start":"2026-05-09T13:42:30.51688Z","end":"2026-05-09T13:42:30.627288Z","steps":["trace[1588027747] 'process raft request' (duration: 77.456523ms)","trace[1588027747] 'compare' (duration: 32.736884ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T13:42:30.751368Z","caller":"traceutil/trace.go:171","msg":"trace[1898589513] transaction","detail":"{read_only:false; response_revision:25029; number_of_response:1; }","duration":"118.676058ms","start":"2026-05-09T13:42:30.632669Z","end":"2026-05-09T13:42:30.751345Z","steps":["trace[1898589513] 'process raft request' (duration: 117.198997ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:42:30.829304Z","caller":"traceutil/trace.go:171","msg":"trace[1013898496] transaction","detail":"{read_only:false; response_revision:25030; number_of_response:1; }","duration":"196.541422ms","start":"2026-05-09T13:42:30.632729Z","end":"2026-05-09T13:42:30.82927Z","steps":["trace[1013898496] 'process raft request' (duration: 196.284875ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:42:30.829316Z","caller":"traceutil/trace.go:171","msg":"trace[1215055492] transaction","detail":"{read_only:false; response_revision:25032; number_of_response:1; }","duration":"196.154871ms","start":"2026-05-09T13:42:30.633134Z","end":"2026-05-09T13:42:30.829289Z","steps":["trace[1215055492] 'process raft request' (duration: 196.075909ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:42:30.829341Z","caller":"traceutil/trace.go:171","msg":"trace[1643471809] transaction","detail":"{read_only:false; response_revision:25031; number_of_response:1; }","duration":"196.539141ms","start":"2026-05-09T13:42:30.632763Z","end":"2026-05-09T13:42:30.829302Z","steps":["trace[1643471809] 'process raft request' (duration: 196.400618ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:42:30.82968Z","caller":"traceutil/trace.go:171","msg":"trace[1388335227] transaction","detail":"{read_only:false; response_revision:25033; number_of_response:1; }","duration":"133.297967ms","start":"2026-05-09T13:42:30.696346Z","end":"2026-05-09T13:42:30.829644Z","steps":["trace[1388335227] 'process raft request' (duration: 132.898116ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:42:30.830036Z","caller":"traceutil/trace.go:171","msg":"trace[1609550310] transaction","detail":"{read_only:false; response_revision:25034; number_of_response:1; }","duration":"109.310462ms","start":"2026-05-09T13:42:30.720649Z","end":"2026-05-09T13:42:30.829959Z","steps":["trace[1609550310] 'process raft request' (duration: 108.900301ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:42:30.83017Z","caller":"traceutil/trace.go:171","msg":"trace[1070508962] transaction","detail":"{read_only:false; response_revision:25035; number_of_response:1; }","duration":"107.589884ms","start":"2026-05-09T13:42:30.722565Z","end":"2026-05-09T13:42:30.830155Z","steps":["trace[1070508962] 'process raft request' (duration: 107.326797ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:42:30.830432Z","caller":"traceutil/trace.go:171","msg":"trace[1929982596] transaction","detail":"{read_only:false; response_revision:25036; number_of_response:1; }","duration":"106.166766ms","start":"2026-05-09T13:42:30.72425Z","end":"2026-05-09T13:42:30.830417Z","steps":["trace[1929982596] 'process raft request' (duration: 105.817727ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:42:30.830448Z","caller":"traceutil/trace.go:171","msg":"trace[1254060862] transaction","detail":"{read_only:false; response_revision:25037; number_of_response:1; }","duration":"104.983184ms","start":"2026-05-09T13:42:30.725447Z","end":"2026-05-09T13:42:30.83043Z","steps":["trace[1254060862] 'process raft request' (duration: 104.881161ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:42:31.043967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.690622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-05-09T13:42:31.044059Z","caller":"traceutil/trace.go:171","msg":"trace[1956582647] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25037; }","duration":"109.845787ms","start":"2026-05-09T13:42:30.934193Z","end":"2026-05-09T13:42:31.044039Z","steps":["trace[1956582647] 'range keys from in-memory index tree' (duration: 109.406235ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:42:31.291069Z","caller":"traceutil/trace.go:171","msg":"trace[2038588940] transaction","detail":"{read_only:false; response_revision:25038; number_of_response:1; }","duration":"150.347842ms","start":"2026-05-09T13:42:31.140672Z","end":"2026-05-09T13:42:31.29102Z","steps":["trace[2038588940] 'process raft request' (duration: 150.015102ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:42:31.567426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.777698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:42:31.567506Z","caller":"traceutil/trace.go:171","msg":"trace[996737911] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:25038; }","duration":"178.916751ms","start":"2026-05-09T13:42:31.388569Z","end":"2026-05-09T13:42:31.567486Z","steps":["trace[996737911] 'count revisions from in-memory index tree' (duration: 178.655624ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:42:51.478424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.816805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-46d221db-f89c-46c9-af89-f01fd5ab290e\" ","response":"range_response_count:1 size:3643"} {"level":"info","ts":"2026-05-09T13:42:51.478521Z","caller":"traceutil/trace.go:171","msg":"trace[550681293] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-46d221db-f89c-46c9-af89-f01fd5ab290e; range_end:; response_count:1; response_revision:25245; }","duration":"128.968189ms","start":"2026-05-09T13:42:51.34953Z","end":"2026-05-09T13:42:51.478498Z","steps":["trace[550681293] 'range keys from in-memory index tree' (duration: 128.590718ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:42:51.47858Z","caller":"traceutil/trace.go:171","msg":"trace[1163102538] transaction","detail":"{read_only:false; response_revision:25246; number_of_response:1; }","duration":"114.012171ms","start":"2026-05-09T13:42:51.364528Z","end":"2026-05-09T13:42:51.47854Z","steps":["trace[1163102538] 'process raft request' (duration: 113.735053ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:42:51.68697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.400156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:42:51.687066Z","caller":"traceutil/trace.go:171","msg":"trace[1241441253] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25246; }","duration":"101.55447ms","start":"2026-05-09T13:42:51.585491Z","end":"2026-05-09T13:42:51.687046Z","steps":["trace[1241441253] 'range keys from in-memory index tree' (duration: 101.314513ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:42:51.9243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.638864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:42:51.924461Z","caller":"traceutil/trace.go:171","msg":"trace[903233588] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:25247; }","duration":"115.85775ms","start":"2026-05-09T13:42:51.80856Z","end":"2026-05-09T13:42:51.924418Z","steps":["trace[903233588] 'count revisions from in-memory index tree' (duration: 115.544622ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:42:59.175864Z","caller":"traceutil/trace.go:171","msg":"trace[1583209000] transaction","detail":"{read_only:false; response_revision:25324; number_of_response:1; }","duration":"169.061532ms","start":"2026-05-09T13:42:59.006781Z","end":"2026-05-09T13:42:59.175843Z","steps":["trace[1583209000] 'process raft request' (duration: 168.924868ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:42:59.177074Z","caller":"traceutil/trace.go:171","msg":"trace[812459647] transaction","detail":"{read_only:false; response_revision:25325; number_of_response:1; }","duration":"169.939486ms","start":"2026-05-09T13:42:59.007117Z","end":"2026-05-09T13:42:59.177057Z","steps":["trace[812459647] 'process raft request' (duration: 169.800073ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:42:59.177058Z","caller":"traceutil/trace.go:171","msg":"trace[936987205] linearizableReadLoop","detail":"{readStateIndex:26148; appliedIndex:26147; }","duration":"168.440695ms","start":"2026-05-09T13:42:59.008595Z","end":"2026-05-09T13:42:59.177036Z","steps":["trace[936987205] 'read index received' (duration: 167.284273ms)","trace[936987205] 'applied index is now lower than readState.Index' (duration: 1.155542ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T13:42:59.177245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.62394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-05-09T13:42:59.177296Z","caller":"traceutil/trace.go:171","msg":"trace[800765931] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25325; }","duration":"168.727173ms","start":"2026-05-09T13:42:59.008557Z","end":"2026-05-09T13:42:59.177284Z","steps":["trace[800765931] 'agreement among raft nodes before linearized reading' (duration: 168.551678ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:43:30.593995Z","caller":"traceutil/trace.go:171","msg":"trace[906190161] linearizableReadLoop","detail":"{readStateIndex:26403; appliedIndex:26402; }","duration":"113.895468ms","start":"2026-05-09T13:43:30.480076Z","end":"2026-05-09T13:43:30.593971Z","steps":["trace[906190161] 'read index received' (duration: 113.751354ms)","trace[906190161] 'applied index is now lower than readState.Index' (duration: 143.234µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T13:43:30.59403Z","caller":"traceutil/trace.go:171","msg":"trace[1657331553] transaction","detail":"{read_only:false; response_revision:25573; number_of_response:1; }","duration":"124.297251ms","start":"2026-05-09T13:43:30.469703Z","end":"2026-05-09T13:43:30.594001Z","steps":["trace[1657331553] 'process raft request' (duration: 124.133507ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:43:30.594111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.00661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:43:30.594145Z","caller":"traceutil/trace.go:171","msg":"trace[665647321] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:25573; }","duration":"114.079713ms","start":"2026-05-09T13:43:30.480054Z","end":"2026-05-09T13:43:30.594133Z","steps":["trace[665647321] 'agreement among raft nodes before linearized reading' (duration: 114.003861ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:43:30.747286Z","caller":"traceutil/trace.go:171","msg":"trace[587615583] transaction","detail":"{read_only:false; response_revision:25574; number_of_response:1; }","duration":"235.194027ms","start":"2026-05-09T13:43:30.51206Z","end":"2026-05-09T13:43:30.747254Z","steps":["trace[587615583] 'process raft request' (duration: 161.394693ms)","trace[587615583] 'compare' (duration: 73.481325ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T13:43:31.194181Z","caller":"traceutil/trace.go:171","msg":"trace[2042057170] linearizableReadLoop","detail":"{readStateIndex:26405; appliedIndex:26404; }","duration":"206.742151ms","start":"2026-05-09T13:43:30.987411Z","end":"2026-05-09T13:43:31.194153Z","steps":["trace[2042057170] 'read index received' (duration: 206.616967ms)","trace[2042057170] 'applied index is now lower than readState.Index' (duration: 124.364µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T13:43:31.194254Z","caller":"traceutil/trace.go:171","msg":"trace[328356490] transaction","detail":"{read_only:false; response_revision:25575; number_of_response:1; }","duration":"255.389537ms","start":"2026-05-09T13:43:30.938841Z","end":"2026-05-09T13:43:31.194231Z","steps":["trace[328356490] 'process raft request' (duration: 255.167791ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:43:31.194394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.970537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"info","ts":"2026-05-09T13:43:31.194429Z","caller":"traceutil/trace.go:171","msg":"trace[832094456] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:25575; }","duration":"207.052739ms","start":"2026-05-09T13:43:30.987366Z","end":"2026-05-09T13:43:31.194419Z","steps":["trace[832094456] 'agreement among raft nodes before linearized reading' (duration: 206.909405ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:43:31.306936Z","caller":"traceutil/trace.go:171","msg":"trace[1259927599] transaction","detail":"{read_only:false; response_revision:25578; number_of_response:1; }","duration":"168.462855ms","start":"2026-05-09T13:43:31.138441Z","end":"2026-05-09T13:43:31.306904Z","steps":["trace[1259927599] 'process raft request' (duration: 168.387513ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:43:31.306926Z","caller":"traceutil/trace.go:171","msg":"trace[1032801290] transaction","detail":"{read_only:false; response_revision:25576; number_of_response:1; }","duration":"212.053055ms","start":"2026-05-09T13:43:31.094839Z","end":"2026-05-09T13:43:31.306892Z","steps":["trace[1032801290] 'process raft request' (duration: 211.814169ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:43:31.306997Z","caller":"traceutil/trace.go:171","msg":"trace[938105428] transaction","detail":"{read_only:false; response_revision:25577; number_of_response:1; }","duration":"198.633679ms","start":"2026-05-09T13:43:31.108355Z","end":"2026-05-09T13:43:31.306989Z","steps":["trace[938105428] 'process raft request' (duration: 198.447524ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:43:31.306979Z","caller":"traceutil/trace.go:171","msg":"trace[1676468320] transaction","detail":"{read_only:false; response_revision:25580; number_of_response:1; }","duration":"167.804868ms","start":"2026-05-09T13:43:31.139152Z","end":"2026-05-09T13:43:31.306957Z","steps":["trace[1676468320] 'process raft request' (duration: 167.716236ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:43:31.306936Z","caller":"traceutil/trace.go:171","msg":"trace[576762898] transaction","detail":"{read_only:false; response_revision:25579; number_of_response:1; }","duration":"168.088926ms","start":"2026-05-09T13:43:31.138832Z","end":"2026-05-09T13:43:31.306921Z","steps":["trace[576762898] 'process raft request' (duration: 168.014744ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:43:31.307265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.182246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-09T13:43:31.307301Z","caller":"traceutil/trace.go:171","msg":"trace[230554354] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25580; }","duration":"158.268017ms","start":"2026-05-09T13:43:31.149024Z","end":"2026-05-09T13:43:31.307292Z","steps":["trace[230554354] 'agreement among raft nodes before linearized reading' (duration: 158.129613ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:43:31.306914Z","caller":"traceutil/trace.go:171","msg":"trace[1019476271] linearizableReadLoop","detail":"{readStateIndex:26410; appliedIndex:26405; }","duration":"112.640542ms","start":"2026-05-09T13:43:31.194254Z","end":"2026-05-09T13:43:31.306895Z","steps":["trace[1019476271] 'read index received' (duration: 112.370485ms)","trace[1019476271] 'applied index is now lower than readState.Index' (duration: 269.107µs)"],"step_count":2} {"level":"warn","ts":"2026-05-09T13:43:36.11801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.438636ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-09T13:43:36.11825Z","caller":"traceutil/trace.go:171","msg":"trace[1706912389] transaction","detail":"{read_only:false; response_revision:25614; number_of_response:1; }","duration":"273.463131ms","start":"2026-05-09T13:43:35.84474Z","end":"2026-05-09T13:43:36.118204Z","steps":["trace[1706912389] 'process raft request' (duration: 93.746517ms)","trace[1706912389] 'compare' (duration: 179.320142ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T13:43:36.118274Z","caller":"traceutil/trace.go:171","msg":"trace[434528623] linearizableReadLoop","detail":"{readStateIndex:26445; appliedIndex:26444; }","duration":"234.677112ms","start":"2026-05-09T13:43:35.88346Z","end":"2026-05-09T13:43:36.118137Z","steps":["trace[434528623] 'read index received' (duration: 52.370139ms)","trace[434528623] 'applied index is now lower than readState.Index' (duration: 182.305473ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T13:43:36.118447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.978591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:562"} {"level":"warn","ts":"2026-05-09T13:43:36.118472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.302249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:43:36.118524Z","caller":"traceutil/trace.go:171","msg":"trace[892903366] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:25614; }","duration":"235.176216ms","start":"2026-05-09T13:43:35.883324Z","end":"2026-05-09T13:43:36.1185Z","steps":["trace[892903366] 'agreement among raft nodes before linearized reading' (duration: 234.970871ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:43:36.118537Z","caller":"traceutil/trace.go:171","msg":"trace[5582238] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25614; }","duration":"103.412112ms","start":"2026-05-09T13:43:36.01511Z","end":"2026-05-09T13:43:36.118522Z","steps":["trace[5582238] 'agreement among raft nodes before linearized reading' (duration: 103.303049ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:43:36.347486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.026006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:43:36.347602Z","caller":"traceutil/trace.go:171","msg":"trace[1622050343] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:25615; }","duration":"101.164731ms","start":"2026-05-09T13:43:36.246409Z","end":"2026-05-09T13:43:36.347573Z","steps":["trace[1622050343] 'count revisions from in-memory index tree' (duration: 100.919703ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:43:55.25409Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22821} {"level":"info","ts":"2026-05-09T13:43:55.385899Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22821,"took":"127.319603ms","hash":608349159,"current-db-size-bytes":58580992,"current-db-size":"59 MB","current-db-size-in-use-bytes":36278272,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-05-09T13:43:55.386029Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":608349159,"revision":22821,"compact-revision":20084} {"level":"info","ts":"2026-05-09T13:43:57.547855Z","caller":"traceutil/trace.go:171","msg":"trace[421048674] transaction","detail":"{read_only:false; response_revision:25908; number_of_response:1; }","duration":"130.454368ms","start":"2026-05-09T13:43:57.417374Z","end":"2026-05-09T13:43:57.547829Z","steps":["trace[421048674] 'process raft request' (duration: 129.398319ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:43:57.548131Z","caller":"traceutil/trace.go:171","msg":"trace[1850931536] transaction","detail":"{read_only:false; response_revision:25909; number_of_response:1; }","duration":"123.676164ms","start":"2026-05-09T13:43:57.424424Z","end":"2026-05-09T13:43:57.548101Z","steps":["trace[1850931536] 'process raft request' (duration: 123.348625ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:43:57.548426Z","caller":"traceutil/trace.go:171","msg":"trace[1370766084] linearizableReadLoop","detail":"{readStateIndex:26748; appliedIndex:26743; }","duration":"119.048407ms","start":"2026-05-09T13:43:57.429351Z","end":"2026-05-09T13:43:57.548399Z","steps":["trace[1370766084] 'read index received' (duration: 41.142513ms)","trace[1370766084] 'applied index is now lower than readState.Index' (duration: 77.904694ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T13:43:57.548527Z","caller":"traceutil/trace.go:171","msg":"trace[389037306] transaction","detail":"{read_only:false; response_revision:25910; number_of_response:1; }","duration":"122.635506ms","start":"2026-05-09T13:43:57.425839Z","end":"2026-05-09T13:43:57.548475Z","steps":["trace[389037306] 'process raft request' (duration: 122.177683ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:43:57.548621Z","caller":"traceutil/trace.go:171","msg":"trace[1990863335] transaction","detail":"{read_only:false; response_revision:25911; number_of_response:1; }","duration":"122.555414ms","start":"2026-05-09T13:43:57.426009Z","end":"2026-05-09T13:43:57.548564Z","steps":["trace[1990863335] 'process raft request' (duration: 122.272785ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:43:57.548713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.338646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-09T13:43:57.548776Z","caller":"traceutil/trace.go:171","msg":"trace[925874120] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25911; }","duration":"119.438019ms","start":"2026-05-09T13:43:57.429322Z","end":"2026-05-09T13:43:57.54876Z","steps":["trace[925874120] 'agreement among raft nodes before linearized reading' (duration: 119.262054ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:44:33.157536Z","caller":"traceutil/trace.go:171","msg":"trace[2133549487] transaction","detail":"{read_only:false; response_revision:26201; number_of_response:1; }","duration":"197.155049ms","start":"2026-05-09T13:44:32.960345Z","end":"2026-05-09T13:44:33.1575Z","steps":["trace[2133549487] 'process raft request' (duration: 196.938393ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:44:38.531465Z","caller":"traceutil/trace.go:171","msg":"trace[1583611264] linearizableReadLoop","detail":"{readStateIndex:27092; appliedIndex:27090; }","duration":"142.290652ms","start":"2026-05-09T13:44:38.389152Z","end":"2026-05-09T13:44:38.531443Z","steps":["trace[1583611264] 'read index received' (duration: 44.383582ms)","trace[1583611264] 'applied index is now lower than readState.Index' (duration: 97.90606ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T13:44:38.531605Z","caller":"traceutil/trace.go:171","msg":"trace[1180379047] transaction","detail":"{read_only:false; response_revision:26244; number_of_response:1; }","duration":"180.087773ms","start":"2026-05-09T13:44:38.351502Z","end":"2026-05-09T13:44:38.53159Z","steps":["trace[1180379047] 'process raft request' (duration: 82.028828ms)","trace[1180379047] 'compare' (duration: 97.666305ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T13:44:38.531944Z","caller":"traceutil/trace.go:171","msg":"trace[2011637804] transaction","detail":"{read_only:false; response_revision:26245; number_of_response:1; }","duration":"143.901415ms","start":"2026-05-09T13:44:38.38801Z","end":"2026-05-09T13:44:38.531911Z","steps":["trace[2011637804] 'process raft request' (duration: 143.367551ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:44:38.53195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.59326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-09T13:44:38.531981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.101086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:44:38.532026Z","caller":"traceutil/trace.go:171","msg":"trace[1050521987] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:26245; }","duration":"142.187339ms","start":"2026-05-09T13:44:38.389829Z","end":"2026-05-09T13:44:38.532016Z","steps":["trace[1050521987] 'agreement among raft nodes before linearized reading' (duration: 142.100516ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:44:38.532035Z","caller":"traceutil/trace.go:171","msg":"trace[2070686050] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26245; }","duration":"142.699203ms","start":"2026-05-09T13:44:38.389314Z","end":"2026-05-09T13:44:38.532014Z","steps":["trace[2070686050] 'agreement among raft nodes before linearized reading' (duration: 142.504257ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:44:38.531996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.782275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-09T13:44:38.532076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.979756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5080"} {"level":"info","ts":"2026-05-09T13:44:38.532135Z","caller":"traceutil/trace.go:171","msg":"trace[508259764] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:26245; }","duration":"141.071129ms","start":"2026-05-09T13:44:38.39105Z","end":"2026-05-09T13:44:38.532121Z","steps":["trace[508259764] 'agreement among raft nodes before linearized reading' (duration: 140.868993ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:44:38.532132Z","caller":"traceutil/trace.go:171","msg":"trace[833965079] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:26245; }","duration":"142.980591ms","start":"2026-05-09T13:44:38.389118Z","end":"2026-05-09T13:44:38.532099Z","steps":["trace[833965079] 'agreement among raft nodes before linearized reading' (duration: 142.628972ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:44:38.827813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.17912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:44:38.827894Z","caller":"traceutil/trace.go:171","msg":"trace[1652671466] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:26245; }","duration":"138.320164ms","start":"2026-05-09T13:44:38.689556Z","end":"2026-05-09T13:44:38.827876Z","steps":["trace[1652671466] 'range keys from in-memory index tree' (duration: 138.076766ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:44:38.828171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.284352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5080"} {"level":"warn","ts":"2026-05-09T13:44:38.828201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.700994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-09T13:44:38.828208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.200048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:44:38.828255Z","caller":"traceutil/trace.go:171","msg":"trace[1441813274] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:26245; }","duration":"138.379465ms","start":"2026-05-09T13:44:38.689857Z","end":"2026-05-09T13:44:38.828236Z","steps":["trace[1441813274] 'range keys from in-memory index tree' (duration: 138.148389ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:44:38.828276Z","caller":"traceutil/trace.go:171","msg":"trace[1423811903] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:26245; }","duration":"139.315591ms","start":"2026-05-09T13:44:38.688947Z","end":"2026-05-09T13:44:38.828263Z","steps":["trace[1423811903] 'range keys from in-memory index tree' (duration: 139.093385ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:44:38.828276Z","caller":"traceutil/trace.go:171","msg":"trace[180172740] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26245; }","duration":"138.841839ms","start":"2026-05-09T13:44:38.689416Z","end":"2026-05-09T13:44:38.828257Z","steps":["trace[180172740] 'range keys from in-memory index tree' (duration: 138.598032ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:44:39.376787Z","caller":"traceutil/trace.go:171","msg":"trace[1971145141] transaction","detail":"{read_only:false; response_revision:26247; number_of_response:1; }","duration":"187.480674ms","start":"2026-05-09T13:44:39.189268Z","end":"2026-05-09T13:44:39.376749Z","steps":["trace[1971145141] 'process raft request' (duration: 187.247548ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:44:39.37689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.279119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:44:39.376944Z","caller":"traceutil/trace.go:171","msg":"trace[159431755] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26247; }","duration":"110.387952ms","start":"2026-05-09T13:44:39.266512Z","end":"2026-05-09T13:44:39.376931Z","steps":["trace[159431755] 'agreement among raft nodes before linearized reading' (duration: 110.279239ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:44:39.376725Z","caller":"traceutil/trace.go:171","msg":"trace[1755285075] linearizableReadLoop","detail":"{readStateIndex:27094; appliedIndex:27093; }","duration":"110.110475ms","start":"2026-05-09T13:44:39.26659Z","end":"2026-05-09T13:44:39.376701Z","steps":["trace[1755285075] 'read index received' (duration: 109.841007ms)","trace[1755285075] 'applied index is now lower than readState.Index' (duration: 267.988µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T13:45:03.941495Z","caller":"traceutil/trace.go:171","msg":"trace[2030767048] transaction","detail":"{read_only:false; response_revision:26439; number_of_response:1; }","duration":"441.130275ms","start":"2026-05-09T13:45:03.500342Z","end":"2026-05-09T13:45:03.941472Z","steps":["trace[2030767048] 'process raft request' (duration: 440.982061ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:03.941748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T13:45:03.500323Z","time spent":"441.33542ms","remote":"127.0.0.1:33560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T13:45:04.430388Z","caller":"traceutil/trace.go:171","msg":"trace[901403274] transaction","detail":"{read_only:false; response_revision:26440; number_of_response:1; }","duration":"735.562306ms","start":"2026-05-09T13:45:03.694807Z","end":"2026-05-09T13:45:04.430369Z","steps":["trace[901403274] 'process raft request' (duration: 735.189496ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:04.430575Z","caller":"traceutil/trace.go:171","msg":"trace[1415824438] transaction","detail":"{read_only:false; response_revision:26445; number_of_response:1; }","duration":"622.133442ms","start":"2026-05-09T13:45:03.808408Z","end":"2026-05-09T13:45:04.430542Z","steps":["trace[1415824438] 'process raft request' (duration: 621.801833ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:04.430373Z","caller":"traceutil/trace.go:171","msg":"trace[1196429837] transaction","detail":"{read_only:false; response_revision:26442; number_of_response:1; }","duration":"626.393018ms","start":"2026-05-09T13:45:03.803952Z","end":"2026-05-09T13:45:04.430345Z","steps":["trace[1196429837] 'process raft request' (duration: 626.191783ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:04.430694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T13:45:03.694781Z","time spent":"735.827473ms","remote":"127.0.0.1:33560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T13:45:04.430723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T13:45:03.803923Z","time spent":"626.763839ms","remote":"127.0.0.1:33560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T13:45:04.430739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T13:45:03.808392Z","time spent":"622.265376ms","remote":"127.0.0.1:33560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T13:45:04.430469Z","caller":"traceutil/trace.go:171","msg":"trace[1814818920] transaction","detail":"{read_only:false; response_revision:26441; number_of_response:1; }","duration":"707.256424ms","start":"2026-05-09T13:45:03.723206Z","end":"2026-05-09T13:45:04.430462Z","steps":["trace[1814818920] 'process raft request' (duration: 706.911464ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:04.4305Z","caller":"traceutil/trace.go:171","msg":"trace[892039858] transaction","detail":"{read_only:false; response_revision:26444; number_of_response:1; }","duration":"623.353645ms","start":"2026-05-09T13:45:03.807142Z","end":"2026-05-09T13:45:04.430496Z","steps":["trace[892039858] 'process raft request' (duration: 623.047057ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:04.430913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T13:45:03.807132Z","time spent":"623.755416ms","remote":"127.0.0.1:33560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T13:45:04.430525Z","caller":"traceutil/trace.go:171","msg":"trace[1342246561] transaction","detail":"{read_only:false; response_revision:26443; number_of_response:1; }","duration":"625.089893ms","start":"2026-05-09T13:45:03.805429Z","end":"2026-05-09T13:45:04.430519Z","steps":["trace[1342246561] 'process raft request' (duration: 624.738374ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:04.430986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T13:45:03.805398Z","time spent":"625.569966ms","remote":"127.0.0.1:33560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T13:45:04.430956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T13:45:03.723188Z","time spent":"707.628444ms","remote":"127.0.0.1:33560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T13:45:04.69738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.128377ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-09T13:45:04.697577Z","caller":"traceutil/trace.go:171","msg":"trace[983430907] linearizableReadLoop","detail":"{readStateIndex:27296; appliedIndex:27289; }","duration":"877.759086ms","start":"2026-05-09T13:45:03.819799Z","end":"2026-05-09T13:45:04.697558Z","steps":["trace[983430907] 'read index received' (duration: 121.598428ms)","trace[983430907] 'applied index is now lower than readState.Index' (duration: 756.159548ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T13:45:04.697791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"877.986573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-05-09T13:45:04.697833Z","caller":"traceutil/trace.go:171","msg":"trace[749499135] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26445; }","duration":"878.076875ms","start":"2026-05-09T13:45:03.819744Z","end":"2026-05-09T13:45:04.697821Z","steps":["trace[749499135] 'agreement among raft nodes before linearized reading' (duration: 877.931091ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:04.697872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T13:45:03.819727Z","time spent":"878.133867ms","remote":"127.0.0.1:33560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-09T13:45:04.698009Z","caller":"traceutil/trace.go:171","msg":"trace[1933307644] transaction","detail":"{read_only:false; response_revision:26446; number_of_response:1; }","duration":"647.916476ms","start":"2026-05-09T13:45:04.050061Z","end":"2026-05-09T13:45:04.697977Z","steps":["trace[1933307644] 'process raft request' (duration: 647.404351ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:04.698219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T13:45:04.050036Z","time spent":"648.0578ms","remote":"127.0.0.1:33560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":495,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T13:45:04.74448Z","caller":"traceutil/trace.go:171","msg":"trace[1206611771] transaction","detail":"{read_only:false; response_revision:26447; number_of_response:1; }","duration":"121.747281ms","start":"2026-05-09T13:45:04.622692Z","end":"2026-05-09T13:45:04.74444Z","steps":["trace[1206611771] 'process raft request' (duration: 75.263074ms)","trace[1206611771] 'compare' (duration: 46.328433ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T13:45:04.744694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"879.572895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-05-09T13:45:04.744732Z","caller":"traceutil/trace.go:171","msg":"trace[974079867] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26448; }","duration":"879.669508ms","start":"2026-05-09T13:45:03.865052Z","end":"2026-05-09T13:45:04.744721Z","steps":["trace[974079867] 'agreement among raft nodes before linearized reading' (duration: 879.473592ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:04.74472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.134597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-05-09T13:45:04.744721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.246236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-09T13:45:04.744756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.192589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5080"} {"level":"warn","ts":"2026-05-09T13:45:04.744754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.784874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-09T13:45:04.744814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"879.599446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-09T13:45:04.744803Z","caller":"traceutil/trace.go:171","msg":"trace[431112349] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:26448; }","duration":"449.385039ms","start":"2026-05-09T13:45:04.295399Z","end":"2026-05-09T13:45:04.744784Z","steps":["trace[431112349] 'agreement among raft nodes before linearized reading' (duration: 449.200154ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:04.744793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"873.725216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-05-09T13:45:04.744833Z","caller":"traceutil/trace.go:171","msg":"trace[700119979] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26448; }","duration":"879.654047ms","start":"2026-05-09T13:45:03.865174Z","end":"2026-05-09T13:45:04.744828Z","steps":["trace[700119979] 'agreement among raft nodes before linearized reading' (duration: 879.600946ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:04.744844Z","caller":"traceutil/trace.go:171","msg":"trace[346273625] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26448; }","duration":"477.911177ms","start":"2026-05-09T13:45:04.266915Z","end":"2026-05-09T13:45:04.744826Z","steps":["trace[346273625] 'agreement among raft nodes before linearized reading' (duration: 477.789894ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:04.744857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T13:45:04.29537Z","time spent":"449.474662ms","remote":"127.0.0.1:33542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" "} {"level":"info","ts":"2026-05-09T13:45:04.744876Z","caller":"traceutil/trace.go:171","msg":"trace[850161933] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26448; }","duration":"873.834099ms","start":"2026-05-09T13:45:03.871021Z","end":"2026-05-09T13:45:04.744855Z","steps":["trace[850161933] 'agreement among raft nodes before linearized reading' (duration: 873.635904ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:04.744892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T13:45:04.266889Z","time spent":"477.994399ms","remote":"127.0.0.1:33312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-09T13:45:04.744927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.127976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1634"} {"level":"warn","ts":"2026-05-09T13:45:04.74492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T13:45:03.87101Z","time spent":"873.901541ms","remote":"127.0.0.1:33560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-09T13:45:04.744937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.583899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"warn","ts":"2026-05-09T13:45:04.74492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"777.650304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-05-09T13:45:04.74495Z","caller":"traceutil/trace.go:171","msg":"trace[465089548] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:26448; }","duration":"602.190088ms","start":"2026-05-09T13:45:04.14275Z","end":"2026-05-09T13:45:04.74494Z","steps":["trace[465089548] 'agreement among raft nodes before linearized reading' (duration: 602.126907ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:04.744967Z","caller":"traceutil/trace.go:171","msg":"trace[349263169] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26448; }","duration":"429.639151ms","start":"2026-05-09T13:45:04.31532Z","end":"2026-05-09T13:45:04.744959Z","steps":["trace[349263169] 'agreement among raft nodes before linearized reading' (duration: 429.550249ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:04.744977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T13:45:04.142729Z","time spent":"602.244609ms","remote":"127.0.0.1:33464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1656,"request content":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" "} {"level":"warn","ts":"2026-05-09T13:45:04.744995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T13:45:04.315306Z","time spent":"429.682252ms","remote":"127.0.0.1:33488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-05-09T13:45:04.744995Z","caller":"traceutil/trace.go:171","msg":"trace[119424483] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:26448; }","duration":"777.772377ms","start":"2026-05-09T13:45:03.9672Z","end":"2026-05-09T13:45:04.744972Z","steps":["trace[119424483] 'agreement among raft nodes before linearized reading' (duration: 777.461079ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:04.744784Z","caller":"traceutil/trace.go:171","msg":"trace[2024588253] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:26448; }","duration":"186.23804ms","start":"2026-05-09T13:45:04.558531Z","end":"2026-05-09T13:45:04.744769Z","steps":["trace[2024588253] 'agreement among raft nodes before linearized reading' (duration: 186.000073ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:04.745051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T13:45:03.967178Z","time spent":"777.85597ms","remote":"127.0.0.1:39142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":167,"response size":31,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"warn","ts":"2026-05-09T13:45:04.744756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T13:45:03.86503Z","time spent":"879.720039ms","remote":"127.0.0.1:33560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-09T13:45:04.745093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.470001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:45:04.745122Z","caller":"traceutil/trace.go:171","msg":"trace[1577947021] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26448; }","duration":"449.520373ms","start":"2026-05-09T13:45:04.295592Z","end":"2026-05-09T13:45:04.745113Z","steps":["trace[1577947021] 'agreement among raft nodes before linearized reading' (duration: 449.469942ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:04.744844Z","caller":"traceutil/trace.go:171","msg":"trace[1350565617] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:26448; }","duration":"447.310682ms","start":"2026-05-09T13:45:04.297506Z","end":"2026-05-09T13:45:04.744817Z","steps":["trace[1350565617] 'agreement among raft nodes before linearized reading' (duration: 447.116707ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:04.745159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T13:45:04.295572Z","time spent":"449.581324ms","remote":"127.0.0.1:33542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/manila-ks-user\" "} {"level":"warn","ts":"2026-05-09T13:45:04.745172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.842438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5080"} {"level":"info","ts":"2026-05-09T13:45:04.745226Z","caller":"traceutil/trace.go:171","msg":"trace[1541309534] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:26448; }","duration":"112.91856ms","start":"2026-05-09T13:45:04.632295Z","end":"2026-05-09T13:45:04.745214Z","steps":["trace[1541309534] 'agreement among raft nodes before linearized reading' (duration: 112.721545ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:04.744858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T13:45:03.865148Z","time spent":"879.706439ms","remote":"127.0.0.1:33560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-09T13:45:04.745253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.204601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:45:04.745284Z","caller":"traceutil/trace.go:171","msg":"trace[67374742] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:26448; }","duration":"145.273024ms","start":"2026-05-09T13:45:04.600003Z","end":"2026-05-09T13:45:04.745276Z","steps":["trace[67374742] 'agreement among raft nodes before linearized reading' (duration: 145.229081ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:04.745269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.515433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:45:04.745322Z","caller":"traceutil/trace.go:171","msg":"trace[1418576186] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:26448; }","duration":"449.628726ms","start":"2026-05-09T13:45:04.295678Z","end":"2026-05-09T13:45:04.745307Z","steps":["trace[1418576186] 'agreement among raft nodes before linearized reading' (duration: 449.548953ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:04.745369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.158593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:45:04.745386Z","caller":"traceutil/trace.go:171","msg":"trace[1572866962] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:26448; }","duration":"115.218384ms","start":"2026-05-09T13:45:04.630161Z","end":"2026-05-09T13:45:04.74538Z","steps":["trace[1572866962] 'agreement among raft nodes before linearized reading' (duration: 115.180413ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:04.745376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T13:45:04.295635Z","time spent":"449.728419ms","remote":"127.0.0.1:33542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/manila-rabbit-init\" "} {"level":"warn","ts":"2026-05-09T13:45:04.745381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.799112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-09T13:45:04.745184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T13:45:04.29749Z","time spent":"447.682152ms","remote":"127.0.0.1:33542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":5102,"request content":"key:\"/registry/jobs/openstack/manila-db-sync\" "} {"level":"info","ts":"2026-05-09T13:45:04.745439Z","caller":"traceutil/trace.go:171","msg":"trace[658844432] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:26448; }","duration":"114.875563ms","start":"2026-05-09T13:45:04.630546Z","end":"2026-05-09T13:45:04.745421Z","steps":["trace[658844432] 'agreement among raft nodes before linearized reading' (duration: 114.779501ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:04.745451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.832463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:45:04.745496Z","caller":"traceutil/trace.go:171","msg":"trace[1847298516] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26448; }","duration":"114.920865ms","start":"2026-05-09T13:45:04.630565Z","end":"2026-05-09T13:45:04.745486Z","steps":["trace[1847298516] 'agreement among raft nodes before linearized reading' (duration: 114.852733ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:04.7455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.243137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-09T13:45:04.745527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.786165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:45:04.745597Z","caller":"traceutil/trace.go:171","msg":"trace[873155254] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26448; }","duration":"146.864997ms","start":"2026-05-09T13:45:04.598716Z","end":"2026-05-09T13:45:04.745581Z","steps":["trace[873155254] 'agreement among raft nodes before linearized reading' (duration: 146.760864ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:04.745542Z","caller":"traceutil/trace.go:171","msg":"trace[1138839695] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:26448; }","duration":"147.316449ms","start":"2026-05-09T13:45:04.598216Z","end":"2026-05-09T13:45:04.745532Z","steps":["trace[1138839695] 'agreement among raft nodes before linearized reading' (duration: 147.255098ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:04.745498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.592462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5080"} {"level":"info","ts":"2026-05-09T13:45:04.74582Z","caller":"traceutil/trace.go:171","msg":"trace[344395207] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:26448; }","duration":"145.919661ms","start":"2026-05-09T13:45:04.599888Z","end":"2026-05-09T13:45:04.745807Z","steps":["trace[344395207] 'agreement among raft nodes before linearized reading' (duration: 145.538001ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:28.474159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.491576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.38\" ","response":"range_response_count:1 size:137"} {"level":"info","ts":"2026-05-09T13:45:28.474287Z","caller":"traceutil/trace.go:171","msg":"trace[882443087] range","detail":"{range_begin:/registry/masterleases/199.204.45.38; range_end:; response_count:1; response_revision:26636; }","duration":"135.66482ms","start":"2026-05-09T13:45:28.338594Z","end":"2026-05-09T13:45:28.474258Z","steps":["trace[882443087] 'range keys from in-memory index tree' (duration: 135.27854ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:28.474343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.817691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:45:28.474403Z","caller":"traceutil/trace.go:171","msg":"trace[838529946] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26636; }","duration":"210.926834ms","start":"2026-05-09T13:45:28.263459Z","end":"2026-05-09T13:45:28.474386Z","steps":["trace[838529946] 'range keys from in-memory index tree' (duration: 210.754749ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:28.987752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.293163ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-09T13:45:28.9881Z","caller":"traceutil/trace.go:171","msg":"trace[829335988] transaction","detail":"{read_only:false; response_revision:26639; number_of_response:1; }","duration":"462.97221ms","start":"2026-05-09T13:45:28.525109Z","end":"2026-05-09T13:45:28.988081Z","steps":["trace[829335988] 'process raft request' (duration: 462.886267ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:28.988113Z","caller":"traceutil/trace.go:171","msg":"trace[613506218] transaction","detail":"{read_only:false; response_revision:26638; number_of_response:1; }","duration":"463.113614ms","start":"2026-05-09T13:45:28.524969Z","end":"2026-05-09T13:45:28.988083Z","steps":["trace[613506218] 'process raft request' (duration: 462.887778ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:28.988169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T13:45:28.525101Z","time spent":"463.035581ms","remote":"127.0.0.1:33560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T13:45:28.988265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T13:45:28.524938Z","time spent":"463.240757ms","remote":"127.0.0.1:33560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T13:45:28.988274Z","caller":"traceutil/trace.go:171","msg":"trace[2054510928] transaction","detail":"{read_only:false; response_revision:26637; number_of_response:1; }","duration":"466.209618ms","start":"2026-05-09T13:45:28.522036Z","end":"2026-05-09T13:45:28.988246Z","steps":["trace[2054510928] 'process raft request' (duration: 364.324129ms)","trace[2054510928] 'compare' (duration: 101.048776ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T13:45:28.98839Z","caller":"traceutil/trace.go:171","msg":"trace[1580777939] transaction","detail":"{read_only:false; response_revision:26640; number_of_response:1; }","duration":"463.204666ms","start":"2026-05-09T13:45:28.525162Z","end":"2026-05-09T13:45:28.988367Z","steps":["trace[1580777939] 'process raft request' (duration: 462.873227ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:28.988464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T13:45:28.522002Z","time spent":"466.357612ms","remote":"127.0.0.1:33560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T13:45:28.988616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T13:45:28.525155Z","time spent":"463.350901ms","remote":"127.0.0.1:33560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T13:45:28.988625Z","caller":"traceutil/trace.go:171","msg":"trace[687035503] transaction","detail":"{read_only:false; response_revision:26641; number_of_response:1; }","duration":"462.723034ms","start":"2026-05-09T13:45:28.52589Z","end":"2026-05-09T13:45:28.988613Z","steps":["trace[687035503] 'process raft request' (duration: 462.371953ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:28.988704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T13:45:28.525878Z","time spent":"462.782805ms","remote":"127.0.0.1:33560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T13:45:28.988948Z","caller":"traceutil/trace.go:171","msg":"trace[298205740] transaction","detail":"{read_only:false; response_revision:26642; number_of_response:1; }","duration":"461.156611ms","start":"2026-05-09T13:45:28.527779Z","end":"2026-05-09T13:45:28.988936Z","steps":["trace[298205740] 'process raft request' (duration: 460.786091ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:28.989032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T13:45:28.527768Z","time spent":"461.226593ms","remote":"127.0.0.1:33560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T13:45:28.989222Z","caller":"traceutil/trace.go:171","msg":"trace[1180926524] transaction","detail":"{read_only:false; response_revision:26643; number_of_response:1; }","duration":"289.885419ms","start":"2026-05-09T13:45:28.699325Z","end":"2026-05-09T13:45:28.989211Z","steps":["trace[1180926524] 'process raft request' (duration: 289.519519ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:28.989303Z","caller":"traceutil/trace.go:171","msg":"trace[64486411] linearizableReadLoop","detail":"{readStateIndex:27503; appliedIndex:27495; }","duration":"180.32538ms","start":"2026-05-09T13:45:28.808956Z","end":"2026-05-09T13:45:28.989282Z","steps":["trace[64486411] 'read index received' (duration: 77.517125ms)","trace[64486411] 'applied index is now lower than readState.Index' (duration: 102.806835ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T13:45:28.989488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.527355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:45:28.989533Z","caller":"traceutil/trace.go:171","msg":"trace[1636228309] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26645; }","duration":"180.611257ms","start":"2026-05-09T13:45:28.808911Z","end":"2026-05-09T13:45:28.989523Z","steps":["trace[1636228309] 'agreement among raft nodes before linearized reading' (duration: 180.533605ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:28.989596Z","caller":"traceutil/trace.go:171","msg":"trace[115359132] transaction","detail":"{read_only:false; response_revision:26644; number_of_response:1; }","duration":"193.437807ms","start":"2026-05-09T13:45:28.796147Z","end":"2026-05-09T13:45:28.989585Z","steps":["trace[115359132] 'process raft request' (duration: 192.960524ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:28.989657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.506465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:45:28.989699Z","caller":"traceutil/trace.go:171","msg":"trace[166360151] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:26645; }","duration":"180.632748ms","start":"2026-05-09T13:45:28.809054Z","end":"2026-05-09T13:45:28.989686Z","steps":["trace[166360151] 'agreement among raft nodes before linearized reading' (duration: 180.513045ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:28.989741Z","caller":"traceutil/trace.go:171","msg":"trace[185880677] transaction","detail":"{read_only:false; response_revision:26645; number_of_response:1; }","duration":"151.645957ms","start":"2026-05-09T13:45:28.838083Z","end":"2026-05-09T13:45:28.989729Z","steps":["trace[185880677] 'process raft request' (duration: 151.136333ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:28.98991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.917087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5080"} {"level":"info","ts":"2026-05-09T13:45:28.989948Z","caller":"traceutil/trace.go:171","msg":"trace[162251876] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:26645; }","duration":"150.966378ms","start":"2026-05-09T13:45:28.838964Z","end":"2026-05-09T13:45:28.98993Z","steps":["trace[162251876] 'agreement among raft nodes before linearized reading' (duration: 150.859706ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:28.989964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.786705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5080"} {"level":"info","ts":"2026-05-09T13:45:28.989996Z","caller":"traceutil/trace.go:171","msg":"trace[1749914551] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:26645; }","duration":"153.857177ms","start":"2026-05-09T13:45:28.836129Z","end":"2026-05-09T13:45:28.989986Z","steps":["trace[1749914551] 'agreement among raft nodes before linearized reading' (duration: 153.729393ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:28.990079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.841396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:45:28.99012Z","caller":"traceutil/trace.go:171","msg":"trace[1361679133] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:26645; }","duration":"179.901557ms","start":"2026-05-09T13:45:28.810206Z","end":"2026-05-09T13:45:28.990108Z","steps":["trace[1361679133] 'agreement among raft nodes before linearized reading' (duration: 179.816135ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:28.990145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.973949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:45:28.990178Z","caller":"traceutil/trace.go:171","msg":"trace[515735760] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26645; }","duration":"180.024981ms","start":"2026-05-09T13:45:28.810143Z","end":"2026-05-09T13:45:28.990168Z","steps":["trace[515735760] 'agreement among raft nodes before linearized reading' (duration: 179.97826ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:28.99023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.817522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:45:28.990274Z","caller":"traceutil/trace.go:171","msg":"trace[2010160497] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26645; }","duration":"180.928125ms","start":"2026-05-09T13:45:28.809334Z","end":"2026-05-09T13:45:28.990262Z","steps":["trace[2010160497] 'agreement among raft nodes before linearized reading' (duration: 180.846333ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:28.990303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.048779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5080"} {"level":"info","ts":"2026-05-09T13:45:28.990353Z","caller":"traceutil/trace.go:171","msg":"trace[1595194327] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:26645; }","duration":"155.116692ms","start":"2026-05-09T13:45:28.835227Z","end":"2026-05-09T13:45:28.990343Z","steps":["trace[1595194327] 'agreement among raft nodes before linearized reading' (duration: 154.969168ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:28.990419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.613886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:45:28.99045Z","caller":"traceutil/trace.go:171","msg":"trace[1027693945] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:26645; }","duration":"180.675348ms","start":"2026-05-09T13:45:28.809766Z","end":"2026-05-09T13:45:28.990441Z","steps":["trace[1027693945] 'agreement among raft nodes before linearized reading' (duration: 180.629887ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:28.990697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.049397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-05-09T13:45:28.990746Z","caller":"traceutil/trace.go:171","msg":"trace[539350097] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26645; }","duration":"123.133969ms","start":"2026-05-09T13:45:28.867602Z","end":"2026-05-09T13:45:28.990736Z","steps":["trace[539350097] 'agreement among raft nodes before linearized reading' (duration: 123.019796ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:28.991024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.756231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:45:28.991053Z","caller":"traceutil/trace.go:171","msg":"trace[1045518669] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:26645; }","duration":"180.804961ms","start":"2026-05-09T13:45:28.81024Z","end":"2026-05-09T13:45:28.991045Z","steps":["trace[1045518669] 'agreement among raft nodes before linearized reading' (duration: 180.75957ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:28.9911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.807092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:45:28.991128Z","caller":"traceutil/trace.go:171","msg":"trace[800971881] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:26645; }","duration":"180.880973ms","start":"2026-05-09T13:45:28.81024Z","end":"2026-05-09T13:45:28.991121Z","steps":["trace[800971881] 'agreement among raft nodes before linearized reading' (duration: 180.830942ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:28.992143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.078885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:45:28.992201Z","caller":"traceutil/trace.go:171","msg":"trace[1990872210] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:26645; }","duration":"180.819763ms","start":"2026-05-09T13:45:28.811371Z","end":"2026-05-09T13:45:28.99219Z","steps":["trace[1990872210] 'agreement among raft nodes before linearized reading' (duration: 179.081275ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:29.352015Z","caller":"traceutil/trace.go:171","msg":"trace[602229692] linearizableReadLoop","detail":"{readStateIndex:27507; appliedIndex:27505; }","duration":"356.258218ms","start":"2026-05-09T13:45:28.995727Z","end":"2026-05-09T13:45:29.351985Z","steps":["trace[602229692] 'read index received' (duration: 69.097465ms)","trace[602229692] 'applied index is now lower than readState.Index' (duration: 287.159793ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T13:45:29.352113Z","caller":"traceutil/trace.go:171","msg":"trace[1969901177] transaction","detail":"{read_only:false; response_revision:26647; number_of_response:1; }","duration":"356.603008ms","start":"2026-05-09T13:45:28.995465Z","end":"2026-05-09T13:45:29.352068Z","steps":["trace[1969901177] 'process raft request' (duration: 333.54903ms)","trace[1969901177] 'compare' (duration: 22.74307ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T13:45:29.352137Z","caller":"traceutil/trace.go:171","msg":"trace[1284932091] transaction","detail":"{read_only:false; response_revision:26648; number_of_response:1; }","duration":"356.414413ms","start":"2026-05-09T13:45:28.995687Z","end":"2026-05-09T13:45:29.352101Z","steps":["trace[1284932091] 'process raft request' (duration: 356.204678ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:29.352214Z","caller":"traceutil/trace.go:171","msg":"trace[1966736775] transaction","detail":"{read_only:false; response_revision:26649; number_of_response:1; }","duration":"356.422033ms","start":"2026-05-09T13:45:28.995775Z","end":"2026-05-09T13:45:29.352197Z","steps":["trace[1966736775] 'process raft request' (duration: 356.169236ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:29.352308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T13:45:28.995667Z","time spent":"356.543586ms","remote":"127.0.0.1:33560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T13:45:29.352321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T13:45:28.995447Z","time spent":"356.760142ms","remote":"127.0.0.1:33560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T13:45:29.352895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.158734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"warn","ts":"2026-05-09T13:45:29.352886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.247131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:45:29.352958Z","caller":"traceutil/trace.go:171","msg":"trace[1802886253] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:26649; }","duration":"357.242796ms","start":"2026-05-09T13:45:28.995701Z","end":"2026-05-09T13:45:29.352943Z","steps":["trace[1802886253] 'agreement among raft nodes before linearized reading' (duration: 357.040841ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:29.353004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T13:45:28.995692Z","time spent":"357.304507ms","remote":"127.0.0.1:33572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"info","ts":"2026-05-09T13:45:29.352998Z","caller":"traceutil/trace.go:171","msg":"trace[1818313932] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:26649; }","duration":"153.449256ms","start":"2026-05-09T13:45:29.199525Z","end":"2026-05-09T13:45:29.352974Z","steps":["trace[1818313932] 'agreement among raft nodes before linearized reading' (duration: 153.23086ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:29.353235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T13:45:28.995764Z","time spent":"356.498225ms","remote":"127.0.0.1:33560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T13:45:29.353354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.848569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1782"} {"level":"info","ts":"2026-05-09T13:45:29.353443Z","caller":"traceutil/trace.go:171","msg":"trace[1966261427] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:26649; }","duration":"238.045974ms","start":"2026-05-09T13:45:29.115371Z","end":"2026-05-09T13:45:29.353417Z","steps":["trace[1966261427] 'agreement among raft nodes before linearized reading' (duration: 237.339805ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:36.798214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.258275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:45:36.798392Z","caller":"traceutil/trace.go:171","msg":"trace[1300397220] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:26696; }","duration":"137.495221ms","start":"2026-05-09T13:45:36.660869Z","end":"2026-05-09T13:45:36.798364Z","steps":["trace[1300397220] 'count revisions from in-memory index tree' (duration: 137.159412ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:36.798431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.414799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-09T13:45:36.798614Z","caller":"traceutil/trace.go:171","msg":"trace[216657895] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:26696; }","duration":"126.627755ms","start":"2026-05-09T13:45:36.67195Z","end":"2026-05-09T13:45:36.798577Z","steps":["trace[216657895] 'count revisions from in-memory index tree' (duration: 126.319476ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:37.227643Z","caller":"traceutil/trace.go:171","msg":"trace[1817742679] transaction","detail":"{read_only:false; response_revision:26700; number_of_response:1; }","duration":"148.722297ms","start":"2026-05-09T13:45:37.078884Z","end":"2026-05-09T13:45:37.227607Z","steps":["trace[1817742679] 'process raft request' (duration: 148.622425ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:37.227661Z","caller":"traceutil/trace.go:171","msg":"trace[317613132] transaction","detail":"{read_only:false; response_revision:26698; number_of_response:1; }","duration":"175.834627ms","start":"2026-05-09T13:45:37.051778Z","end":"2026-05-09T13:45:37.227612Z","steps":["trace[317613132] 'process raft request' (duration: 175.509657ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:37.227667Z","caller":"traceutil/trace.go:171","msg":"trace[30542357] transaction","detail":"{read_only:false; response_revision:26699; number_of_response:1; }","duration":"151.553154ms","start":"2026-05-09T13:45:37.076079Z","end":"2026-05-09T13:45:37.227632Z","steps":["trace[30542357] 'process raft request' (duration: 151.366759ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:37.228047Z","caller":"traceutil/trace.go:171","msg":"trace[108854455] transaction","detail":"{read_only:false; response_revision:26702; number_of_response:1; }","duration":"148.233994ms","start":"2026-05-09T13:45:37.0798Z","end":"2026-05-09T13:45:37.228034Z","steps":["trace[108854455] 'process raft request' (duration: 148.055739ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:37.228087Z","caller":"traceutil/trace.go:171","msg":"trace[918060731] transaction","detail":"{read_only:false; response_revision:26701; number_of_response:1; }","duration":"148.742318ms","start":"2026-05-09T13:45:37.079296Z","end":"2026-05-09T13:45:37.228039Z","steps":["trace[918060731] 'process raft request' (duration: 148.265955ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:37.228182Z","caller":"traceutil/trace.go:171","msg":"trace[350821271] linearizableReadLoop","detail":"{readStateIndex:27564; appliedIndex:27557; }","duration":"142.94697ms","start":"2026-05-09T13:45:37.085202Z","end":"2026-05-09T13:45:37.228149Z","steps":["trace[350821271] 'read index received' (duration: 142.020524ms)","trace[350821271] 'applied index is now lower than readState.Index' (duration: 925.396µs)"],"step_count":2} {"level":"warn","ts":"2026-05-09T13:45:37.228285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.11355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-09T13:45:37.228311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.88038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:45:37.228338Z","caller":"traceutil/trace.go:171","msg":"trace[1187645221] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:26704; }","duration":"148.214094ms","start":"2026-05-09T13:45:37.080108Z","end":"2026-05-09T13:45:37.228322Z","steps":["trace[1187645221] 'agreement among raft nodes before linearized reading' (duration: 148.07449ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:37.228358Z","caller":"traceutil/trace.go:171","msg":"trace[899482979] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26704; }","duration":"145.950531ms","start":"2026-05-09T13:45:37.082393Z","end":"2026-05-09T13:45:37.228343Z","steps":["trace[899482979] 'agreement among raft nodes before linearized reading' (duration: 145.861409ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:37.22839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.642999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:45:37.228445Z","caller":"traceutil/trace.go:171","msg":"trace[1291039341] transaction","detail":"{read_only:false; response_revision:26703; number_of_response:1; }","duration":"147.054193ms","start":"2026-05-09T13:45:37.081382Z","end":"2026-05-09T13:45:37.228436Z","steps":["trace[1291039341] 'process raft request' (duration: 146.610831ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:37.228446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.525435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:45:37.228457Z","caller":"traceutil/trace.go:171","msg":"trace[693632461] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:26704; }","duration":"147.746101ms","start":"2026-05-09T13:45:37.080694Z","end":"2026-05-09T13:45:37.22844Z","steps":["trace[693632461] 'agreement among raft nodes before linearized reading' (duration: 147.616567ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:37.228467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.324817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5080"} {"level":"info","ts":"2026-05-09T13:45:37.22851Z","caller":"traceutil/trace.go:171","msg":"trace[116725029] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:26704; }","duration":"148.405638ms","start":"2026-05-09T13:45:37.080091Z","end":"2026-05-09T13:45:37.228497Z","steps":["trace[116725029] 'agreement among raft nodes before linearized reading' (duration: 148.230724ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:37.228516Z","caller":"traceutil/trace.go:171","msg":"trace[1049193676] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:26704; }","duration":"147.608867ms","start":"2026-05-09T13:45:37.080872Z","end":"2026-05-09T13:45:37.228481Z","steps":["trace[1049193676] 'agreement among raft nodes before linearized reading' (duration: 147.470553ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:37.228541Z","caller":"traceutil/trace.go:171","msg":"trace[1720851660] transaction","detail":"{read_only:false; response_revision:26704; number_of_response:1; }","duration":"145.088828ms","start":"2026-05-09T13:45:37.083443Z","end":"2026-05-09T13:45:37.228531Z","steps":["trace[1720851660] 'process raft request' (duration: 144.589985ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:37.228612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.215703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:45:37.228657Z","caller":"traceutil/trace.go:171","msg":"trace[153727637] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:26704; }","duration":"148.280345ms","start":"2026-05-09T13:45:37.080367Z","end":"2026-05-09T13:45:37.228647Z","steps":["trace[153727637] 'agreement among raft nodes before linearized reading' (duration: 148.208413ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:37.228666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.028055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-09T13:45:37.228696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.266141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5080"} {"level":"info","ts":"2026-05-09T13:45:37.228731Z","caller":"traceutil/trace.go:171","msg":"trace[1146566791] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:26704; }","duration":"146.308691ms","start":"2026-05-09T13:45:37.082414Z","end":"2026-05-09T13:45:37.228723Z","steps":["trace[1146566791] 'agreement among raft nodes before linearized reading' (duration: 146.189878ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:37.228761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.250361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5080"} {"level":"warn","ts":"2026-05-09T13:45:37.228774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.842281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-09T13:45:37.228783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.958634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:45:37.228736Z","caller":"traceutil/trace.go:171","msg":"trace[860963238] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:26704; }","duration":"149.115427ms","start":"2026-05-09T13:45:37.079605Z","end":"2026-05-09T13:45:37.22872Z","steps":["trace[860963238] 'agreement among raft nodes before linearized reading' (duration: 149.006814ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:37.228818Z","caller":"traceutil/trace.go:171","msg":"trace[1430373935] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:26704; }","duration":"149.028075ms","start":"2026-05-09T13:45:37.079781Z","end":"2026-05-09T13:45:37.228809Z","steps":["trace[1430373935] 'agreement among raft nodes before linearized reading' (duration: 148.979203ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:37.228739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.376326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/glance-api-cf5884c6c-r54vq.18ade7e017f4994e\" ","response":"range_response_count:1 size:2093"} {"level":"info","ts":"2026-05-09T13:45:37.228919Z","caller":"traceutil/trace.go:171","msg":"trace[1827306691] range","detail":"{range_begin:/registry/events/openstack/glance-api-cf5884c6c-r54vq.18ade7e017f4994e; range_end:; response_count:1; response_revision:26704; }","duration":"134.56295ms","start":"2026-05-09T13:45:37.094341Z","end":"2026-05-09T13:45:37.228904Z","steps":["trace[1827306691] 'agreement among raft nodes before linearized reading' (duration: 134.322384ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:37.228902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.345134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:45:37.228963Z","caller":"traceutil/trace.go:171","msg":"trace[1274536272] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:26704; }","duration":"149.417846ms","start":"2026-05-09T13:45:37.079537Z","end":"2026-05-09T13:45:37.228955Z","steps":["trace[1274536272] 'agreement among raft nodes before linearized reading' (duration: 149.344744ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:37.228804Z","caller":"traceutil/trace.go:171","msg":"trace[816605264] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:26704; }","duration":"149.327733ms","start":"2026-05-09T13:45:37.079467Z","end":"2026-05-09T13:45:37.228795Z","steps":["trace[816605264] 'agreement among raft nodes before linearized reading' (duration: 149.153129ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:37.228809Z","caller":"traceutil/trace.go:171","msg":"trace[1384146208] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26704; }","duration":"148.915883ms","start":"2026-05-09T13:45:37.079884Z","end":"2026-05-09T13:45:37.2288Z","steps":["trace[1384146208] 'agreement among raft nodes before linearized reading' (duration: 148.866721ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:37.229029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.378775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5080"} {"level":"info","ts":"2026-05-09T13:45:37.22906Z","caller":"traceutil/trace.go:171","msg":"trace[1186966955] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:26704; }","duration":"149.420156ms","start":"2026-05-09T13:45:37.07963Z","end":"2026-05-09T13:45:37.22905Z","steps":["trace[1186966955] 'agreement among raft nodes before linearized reading' (duration: 149.279663ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:37.228859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.267932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:45:37.229126Z","caller":"traceutil/trace.go:171","msg":"trace[2085822358] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26704; }","duration":"149.542229ms","start":"2026-05-09T13:45:37.079573Z","end":"2026-05-09T13:45:37.229115Z","steps":["trace[2085822358] 'agreement among raft nodes before linearized reading' (duration: 149.261931ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:37.228864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.904402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:45:37.229181Z","caller":"traceutil/trace.go:171","msg":"trace[1752125417] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26704; }","duration":"149.22672ms","start":"2026-05-09T13:45:37.079937Z","end":"2026-05-09T13:45:37.229164Z","steps":["trace[1752125417] 'agreement among raft nodes before linearized reading' (duration: 148.899712ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:37.530525Z","caller":"traceutil/trace.go:171","msg":"trace[2139086804] linearizableReadLoop","detail":"{readStateIndex:27566; appliedIndex:27564; }","duration":"287.081953ms","start":"2026-05-09T13:45:37.243417Z","end":"2026-05-09T13:45:37.530499Z","steps":["trace[2139086804] 'read index received' (duration: 59.954766ms)","trace[2139086804] 'applied index is now lower than readState.Index' (duration: 227.126217ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T13:45:37.530579Z","caller":"traceutil/trace.go:171","msg":"trace[275161248] transaction","detail":"{read_only:false; response_revision:26706; number_of_response:1; }","duration":"290.632739ms","start":"2026-05-09T13:45:37.239908Z","end":"2026-05-09T13:45:37.530541Z","steps":["trace[275161248] 'process raft request' (duration: 290.402613ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:37.530728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.273948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:45:37.53082Z","caller":"traceutil/trace.go:171","msg":"trace[1067449533] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates0; response_count:0; response_revision:26706; }","duration":"287.430892ms","start":"2026-05-09T13:45:37.243369Z","end":"2026-05-09T13:45:37.530799Z","steps":["trace[1067449533] 'agreement among raft nodes before linearized reading' (duration: 287.264807ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:37.640482Z","caller":"traceutil/trace.go:171","msg":"trace[1109822214] linearizableReadLoop","detail":"{readStateIndex:27567; appliedIndex:27566; }","duration":"109.858447ms","start":"2026-05-09T13:45:37.530599Z","end":"2026-05-09T13:45:37.640457Z","steps":["trace[1109822214] 'read index received' (duration: 47.594749ms)","trace[1109822214] 'applied index is now lower than readState.Index' (duration: 62.262838ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T13:45:37.640561Z","caller":"traceutil/trace.go:171","msg":"trace[1953407518] transaction","detail":"{read_only:false; response_revision:26707; number_of_response:1; }","duration":"203.703767ms","start":"2026-05-09T13:45:37.436832Z","end":"2026-05-09T13:45:37.640536Z","steps":["trace[1953407518] 'process raft request' (duration: 141.326136ms)","trace[1953407518] 'compare' (duration: 62.164246ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T13:45:37.640618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.482709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:45:37.640653Z","caller":"traceutil/trace.go:171","msg":"trace[699157873] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26707; }","duration":"373.555301ms","start":"2026-05-09T13:45:37.267085Z","end":"2026-05-09T13:45:37.64064Z","steps":["trace[699157873] 'agreement among raft nodes before linearized reading' (duration: 373.469089ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:37.640694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T13:45:37.267073Z","time spent":"373.612272ms","remote":"127.0.0.1:33312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-09T13:45:37.640718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.243924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-05-09T13:45:37.640753Z","caller":"traceutil/trace.go:171","msg":"trace[1420097775] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26707; }","duration":"225.310126ms","start":"2026-05-09T13:45:37.41543Z","end":"2026-05-09T13:45:37.64074Z","steps":["trace[1420097775] 'agreement among raft nodes before linearized reading' (duration: 225.249264ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:37.640716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.780187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/users/\" range_end:\"/registry/openstack.k-orc.cloud/users0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-09T13:45:37.640638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.057002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-05-09T13:45:37.640816Z","caller":"traceutil/trace.go:171","msg":"trace[1356218836] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/users/; range_end:/registry/openstack.k-orc.cloud/users0; response_count:0; response_revision:26707; }","duration":"215.956281ms","start":"2026-05-09T13:45:37.424835Z","end":"2026-05-09T13:45:37.640791Z","steps":["trace[1356218836] 'agreement among raft nodes before linearized reading' (duration: 215.740015ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:37.640804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.444086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/flavors/\" range_end:\"/registry/openstack.k-orc.cloud/flavors0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:45:37.640862Z","caller":"traceutil/trace.go:171","msg":"trace[1059464185] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26707; }","duration":"213.311419ms","start":"2026-05-09T13:45:37.427512Z","end":"2026-05-09T13:45:37.640824Z","steps":["trace[1059464185] 'agreement among raft nodes before linearized reading' (duration: 212.951349ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:37.640919Z","caller":"traceutil/trace.go:171","msg":"trace[1245646863] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/flavors/; range_end:/registry/openstack.k-orc.cloud/flavors0; response_count:0; response_revision:26707; }","duration":"120.636451ms","start":"2026-05-09T13:45:37.520252Z","end":"2026-05-09T13:45:37.640889Z","steps":["trace[1245646863] 'agreement among raft nodes before linearized reading' (duration: 120.379264ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:37.641539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.138412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-09T13:45:37.641596Z","caller":"traceutil/trace.go:171","msg":"trace[1726662984] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26707; }","duration":"218.234284ms","start":"2026-05-09T13:45:37.423348Z","end":"2026-05-09T13:45:37.641582Z","steps":["trace[1726662984] 'agreement among raft nodes before linearized reading' (duration: 217.185636ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:37.854018Z","caller":"traceutil/trace.go:171","msg":"trace[92428489] transaction","detail":"{read_only:false; response_revision:26709; number_of_response:1; }","duration":"208.291192ms","start":"2026-05-09T13:45:37.645691Z","end":"2026-05-09T13:45:37.853982Z","steps":["trace[92428489] 'process raft request' (duration: 139.082343ms)","trace[92428489] 'compare' (duration: 68.908201ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T13:45:37.854098Z","caller":"traceutil/trace.go:171","msg":"trace[1206137157] transaction","detail":"{read_only:false; response_revision:26710; number_of_response:1; }","duration":"206.651818ms","start":"2026-05-09T13:45:37.647401Z","end":"2026-05-09T13:45:37.854052Z","steps":["trace[1206137157] 'process raft request' (duration: 206.489993ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:37.853996Z","caller":"traceutil/trace.go:171","msg":"trace[1665084025] linearizableReadLoop","detail":"{readStateIndex:27570; appliedIndex:27567; }","duration":"170.184743ms","start":"2026-05-09T13:45:37.683778Z","end":"2026-05-09T13:45:37.853962Z","steps":["trace[1665084025] 'read index received' (duration: 6.55109ms)","trace[1665084025] 'applied index is now lower than readState.Index' (duration: 163.632253ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T13:45:37.854262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.46932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-05-09T13:45:37.854335Z","caller":"traceutil/trace.go:171","msg":"trace[275143427] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:26710; }","duration":"170.601974ms","start":"2026-05-09T13:45:37.683714Z","end":"2026-05-09T13:45:37.854316Z","steps":["trace[275143427] 'agreement among raft nodes before linearized reading' (duration: 170.355147ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:37.854401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.993411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/groups/\" range_end:\"/registry/openstack.k-orc.cloud/groups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:45:37.854478Z","caller":"traceutil/trace.go:171","msg":"trace[1346983560] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/groups/; range_end:/registry/openstack.k-orc.cloud/groups0; response_count:0; response_revision:26710; }","duration":"139.145206ms","start":"2026-05-09T13:45:37.715314Z","end":"2026-05-09T13:45:37.854459Z","steps":["trace[1346983560] 'agreement among raft nodes before linearized reading' (duration: 138.985111ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:38.324883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.73109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:45:38.324989Z","caller":"traceutil/trace.go:171","msg":"trace[1022457706] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:26711; }","duration":"235.892475ms","start":"2026-05-09T13:45:38.08907Z","end":"2026-05-09T13:45:38.324963Z","steps":["trace[1022457706] 'count revisions from in-memory index tree' (duration: 235.603406ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:38.324884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.295921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:45:38.325294Z","caller":"traceutil/trace.go:171","msg":"trace[1115147219] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackmachines/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackmachines0; response_count:0; response_revision:26711; }","duration":"293.767303ms","start":"2026-05-09T13:45:38.031503Z","end":"2026-05-09T13:45:38.32527Z","steps":["trace[1115147219] 'count revisions from in-memory index tree' (duration: 293.191457ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:39.821441Z","caller":"traceutil/trace.go:171","msg":"trace[906915962] transaction","detail":"{read_only:false; response_revision:26723; number_of_response:1; }","duration":"122.583663ms","start":"2026-05-09T13:45:39.698309Z","end":"2026-05-09T13:45:39.820893Z","steps":["trace[906915962] 'process raft request' (duration: 122.404358ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:40.0084Z","caller":"traceutil/trace.go:171","msg":"trace[313292011] transaction","detail":"{read_only:false; response_revision:26724; number_of_response:1; }","duration":"145.445828ms","start":"2026-05-09T13:45:39.86293Z","end":"2026-05-09T13:45:40.008376Z","steps":["trace[313292011] 'process raft request' (duration: 71.947963ms)","trace[313292011] 'compare' (duration: 73.31966ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T13:45:40.008697Z","caller":"traceutil/trace.go:171","msg":"trace[1024276409] transaction","detail":"{read_only:false; response_revision:26725; number_of_response:1; }","duration":"144.855421ms","start":"2026-05-09T13:45:39.863761Z","end":"2026-05-09T13:45:40.008617Z","steps":["trace[1024276409] 'process raft request' (duration: 144.564443ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:41.950236Z","caller":"traceutil/trace.go:171","msg":"trace[604237075] transaction","detail":"{read_only:false; response_revision:26738; number_of_response:1; }","duration":"120.257401ms","start":"2026-05-09T13:45:41.829945Z","end":"2026-05-09T13:45:41.950203Z","steps":["trace[604237075] 'process raft request' (duration: 120.064725ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T13:45:52.748383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.817141ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-09T13:45:52.748593Z","caller":"traceutil/trace.go:171","msg":"trace[1003200165] linearizableReadLoop","detail":"{readStateIndex:27679; appliedIndex:27678; }","duration":"284.46029ms","start":"2026-05-09T13:45:52.464108Z","end":"2026-05-09T13:45:52.748568Z","steps":["trace[1003200165] 'read index received' (duration: 161.429524ms)","trace[1003200165] 'applied index is now lower than readState.Index' (duration: 123.029086ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T13:45:52.748722Z","caller":"traceutil/trace.go:171","msg":"trace[1975077229] transaction","detail":"{read_only:false; response_revision:26816; number_of_response:1; }","duration":"286.958148ms","start":"2026-05-09T13:45:52.46175Z","end":"2026-05-09T13:45:52.748709Z","steps":["trace[1975077229] 'process raft request' (duration: 163.742366ms)","trace[1975077229] 'compare' (duration: 122.724818ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T13:45:52.74893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.820109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-09T13:45:52.748963Z","caller":"traceutil/trace.go:171","msg":"trace[1674013980] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:26817; }","duration":"284.879272ms","start":"2026-05-09T13:45:52.46407Z","end":"2026-05-09T13:45:52.74895Z","steps":["trace[1674013980] 'agreement among raft nodes before linearized reading' (duration: 284.837791ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T13:45:56.124483Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006c3b.wal"} {"level":"info","ts":"2026-05-09T13:48:55.268324Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25891} {"level":"info","ts":"2026-05-09T13:48:55.422444Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25891,"took":"150.180666ms","hash":3808079747,"current-db-size-bytes":58580992,"current-db-size":"59 MB","current-db-size-in-use-bytes":34746368,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-05-09T13:48:55.422514Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3808079747,"revision":25891,"compact-revision":22821} {"level":"info","ts":"2026-05-09T13:49:56.394508Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"331455d6226d3423","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-09T13:49:56.399662Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-05-09T13:49:56.399769Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-05-09T13:53:55.276775Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28538} {"level":"info","ts":"2026-05-09T13:53:55.409751Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28538,"took":"129.627809ms","hash":1618601603,"current-db-size-bytes":58580992,"current-db-size":"59 MB","current-db-size-in-use-bytes":30838784,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-05-09T13:53:55.409834Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1618601603,"revision":28538,"compact-revision":25891} {"level":"info","ts":"2026-05-09T13:58:55.283006Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30861} {"level":"info","ts":"2026-05-09T13:58:55.41522Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30861,"took":"127.477967ms","hash":235546097,"current-db-size-bytes":58580992,"current-db-size":"59 MB","current-db-size-in-use-bytes":30265344,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-09T13:58:55.415271Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":235546097,"revision":30861,"compact-revision":28538} {"level":"info","ts":"2026-05-09T14:03:55.292178Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33127} {"level":"info","ts":"2026-05-09T14:03:55.45294Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33127,"took":"154.985351ms","hash":2661316976,"current-db-size-bytes":59625472,"current-db-size":"60 MB","current-db-size-in-use-bytes":31551488,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-05-09T14:03:55.452992Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2661316976,"revision":33127,"compact-revision":30861} {"level":"info","ts":"2026-05-09T14:08:55.31074Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35485} {"level":"info","ts":"2026-05-09T14:08:55.458752Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35485,"took":"144.676638ms","hash":826119011,"current-db-size-bytes":60477440,"current-db-size":"60 MB","current-db-size-in-use-bytes":32026624,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-05-09T14:08:55.458843Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":826119011,"revision":35485,"compact-revision":33127} {"level":"info","ts":"2026-05-09T14:11:08.900962Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"331455d6226d3423","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-09T14:11:08.906807Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-05-09T14:11:08.906953Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-05-09T14:13:55.319515Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37752} {"level":"info","ts":"2026-05-09T14:13:55.438216Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37752,"took":"114.006812ms","hash":3418114631,"current-db-size-bytes":60899328,"current-db-size":"61 MB","current-db-size-in-use-bytes":31776768,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-05-09T14:13:55.438273Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3418114631,"revision":37752,"compact-revision":35485}