{"level":"warn","ts":"2026-05-26T20:16:26.60138Z","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-26T20:16:26.601496Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.132: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.132:2380","--initial-cluster=instance=https://199.204.45.132:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.132:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.132: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-26T20:16:26.601568Z","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-26T20:16:26.601594Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.132:2380"]} {"level":"info","ts":"2026-05-26T20:16:26.60162Z","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-26T20:16:26.602237Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"]} {"level":"info","ts":"2026-05-26T20:16:26.602337Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.132:2380"],"listen-peer-urls":["https://199.204.45.132:2380"],"advertise-client-urls":["https://199.204.45.132:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.132: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-26T20:16:26.60622Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.681256ms"} {"level":"info","ts":"2026-05-26T20:16:26.613825Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"56c01ea8fdc90390","cluster-id":"c930fe821aab8609"} {"level":"info","ts":"2026-05-26T20:16:26.613908Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=()"} {"level":"info","ts":"2026-05-26T20:16:26.613937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became follower at term 0"} {"level":"info","ts":"2026-05-26T20:16:26.613957Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 56c01ea8fdc90390 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-26T20:16:26.613983Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became follower at term 1"} {"level":"info","ts":"2026-05-26T20:16:26.614024Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=(6251029993951396752)"} {"level":"warn","ts":"2026-05-26T20:16:26.622697Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-26T20:16:26.624455Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-26T20:16:26.625593Z","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-26T20:16:26.627874Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"56c01ea8fdc90390","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-26T20:16:26.627995Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"56c01ea8fdc90390","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-26T20:16:26.627986Z","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-26T20:16:26.628138Z","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-26T20:16:26.628165Z","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-26T20:16:26.632082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 switched to configuration voters=(6251029993951396752)"} {"level":"info","ts":"2026-05-26T20:16:26.632229Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c930fe821aab8609","local-member-id":"56c01ea8fdc90390","added-peer-id":"56c01ea8fdc90390","added-peer-peer-urls":["https://199.204.45.132:2380"]} {"level":"info","ts":"2026-05-26T20:16:26.640479Z","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-26T20:16:26.640587Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.132:2380"} {"level":"info","ts":"2026-05-26T20:16:26.640658Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.132:2380"} {"level":"info","ts":"2026-05-26T20:16:26.640947Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"56c01ea8fdc90390","initial-advertise-peer-urls":["https://199.204.45.132:2380"],"listen-peer-urls":["https://199.204.45.132:2380"],"advertise-client-urls":["https://199.204.45.132:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.132:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-26T20:16:26.641026Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-26T20:16:27.414776Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 is starting a new election at term 1"} {"level":"info","ts":"2026-05-26T20:16:27.414832Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-26T20:16:27.414875Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 received MsgPreVoteResp from 56c01ea8fdc90390 at term 1"} {"level":"info","ts":"2026-05-26T20:16:27.4149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became candidate at term 2"} {"level":"info","ts":"2026-05-26T20:16:27.414916Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 received MsgVoteResp from 56c01ea8fdc90390 at term 2"} {"level":"info","ts":"2026-05-26T20:16:27.414937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"56c01ea8fdc90390 became leader at term 2"} {"level":"info","ts":"2026-05-26T20:16:27.414955Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 56c01ea8fdc90390 elected leader 56c01ea8fdc90390 at term 2"} {"level":"info","ts":"2026-05-26T20:16:27.41885Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T20:16:27.419348Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"56c01ea8fdc90390","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.132:2379]}","request-path":"/0/members/56c01ea8fdc90390/attributes","cluster-id":"c930fe821aab8609","publish-timeout":"7s"} {"level":"info","ts":"2026-05-26T20:16:27.41958Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-26T20:16:27.419636Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-26T20:16:27.419811Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c930fe821aab8609","local-member-id":"56c01ea8fdc90390","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T20:16:27.419916Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T20:16:27.419955Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T20:16:27.422448Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-26T20:16:27.422694Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-26T20:16:27.422739Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-26T20:16:27.424155Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.132:2379"} {"level":"info","ts":"2026-05-26T20:16:32.899588Z","caller":"traceutil/trace.go:171","msg":"trace[1411458326] transaction","detail":"{read_only:false; response_revision:303; number_of_response:1; }","duration":"231.703ms","start":"2026-05-26T20:16:32.66786Z","end":"2026-05-26T20:16:32.899563Z","steps":["trace[1411458326] 'process raft request' (duration: 231.590482ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:16:33.195447Z","caller":"traceutil/trace.go:171","msg":"trace[1328611187] transaction","detail":"{read_only:false; response_revision:304; number_of_response:1; }","duration":"491.838209ms","start":"2026-05-26T20:16:32.703576Z","end":"2026-05-26T20:16:33.195414Z","steps":["trace[1328611187] 'process raft request' (duration: 491.615625ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:16:33.19549Z","caller":"traceutil/trace.go:171","msg":"trace[1868323820] transaction","detail":"{read_only:false; number_of_response:0; response_revision:304; }","duration":"384.999924ms","start":"2026-05-26T20:16:32.810468Z","end":"2026-05-26T20:16:33.195468Z","steps":["trace[1868323820] 'process raft request' (duration: 384.883597ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:16:33.195554Z","caller":"traceutil/trace.go:171","msg":"trace[567049052] transaction","detail":"{read_only:false; number_of_response:0; response_revision:304; }","duration":"384.664213ms","start":"2026-05-26T20:16:32.810856Z","end":"2026-05-26T20:16:33.19552Z","steps":["trace[567049052] 'process raft request' (duration: 384.531304ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:16:33.195448Z","caller":"traceutil/trace.go:171","msg":"trace[21985562] linearizableReadLoop","detail":"{readStateIndex:312; appliedIndex:310; }","duration":"386.19678ms","start":"2026-05-26T20:16:32.809221Z","end":"2026-05-26T20:16:33.195418Z","steps":["trace[21985562] 'read index received' (duration: 90.288366ms)","trace[21985562] 'applied index is now lower than readState.Index' (duration: 295.907074ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T20:16:33.195615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.348619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3980"} {"level":"info","ts":"2026-05-26T20:16:33.19572Z","caller":"traceutil/trace.go:171","msg":"trace[1261740411] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:304; }","duration":"386.52584ms","start":"2026-05-26T20:16:32.809184Z","end":"2026-05-26T20:16:33.19571Z","steps":["trace[1261740411] 'agreement among raft nodes before linearized reading' (duration: 386.330178ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:16:33.195763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:16:32.809166Z","time spent":"386.588694ms","remote":"127.0.0.1:54990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":4003,"request content":"key:\"/registry/pods/kube-system/etcd-instance\" "} {"level":"warn","ts":"2026-05-26T20:16:33.196192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:16:32.703559Z","time spent":"491.973407ms","remote":"127.0.0.1:55008","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":201,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T20:16:33.196335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:16:32.810453Z","time spent":"385.08488ms","remote":"127.0.0.1:54990","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T20:16:33.196477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:16:32.810831Z","time spent":"384.826353ms","remote":"127.0.0.1:54990","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T20:16:33.558202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.702611ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-26T20:16:33.558313Z","caller":"traceutil/trace.go:171","msg":"trace[106809063] linearizableReadLoop","detail":"{readStateIndex:315; appliedIndex:314; }","duration":"362.61192ms","start":"2026-05-26T20:16:33.195686Z","end":"2026-05-26T20:16:33.558298Z","steps":["trace[106809063] 'read index received' (duration: 153.688946ms)","trace[106809063] 'applied index is now lower than readState.Index' (duration: 208.921864ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T20:16:33.558431Z","caller":"traceutil/trace.go:171","msg":"trace[1287239805] transaction","detail":"{read_only:false; response_revision:305; number_of_response:1; }","duration":"655.036635ms","start":"2026-05-26T20:16:32.903341Z","end":"2026-05-26T20:16:33.558377Z","steps":["trace[1287239805] 'process raft request' (duration: 445.94057ms)","trace[1287239805] 'compare' (duration: 208.258802ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T20:16:33.558466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.037536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-26T20:16:33.558628Z","caller":"traceutil/trace.go:171","msg":"trace[373542562] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:305; }","duration":"655.244048ms","start":"2026-05-26T20:16:32.90337Z","end":"2026-05-26T20:16:33.558614Z","steps":["trace[373542562] 'agreement among raft nodes before linearized reading' (duration: 655.000103ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:16:33.558674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:16:32.903352Z","time spent":"655.305192ms","remote":"127.0.0.1:55048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-26T20:16:33.558703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:16:32.903325Z","time spent":"655.245078ms","remote":"127.0.0.1:54880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":705,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T20:16:33.719637Z","caller":"traceutil/trace.go:171","msg":"trace[1426465730] linearizableReadLoop","detail":"{readStateIndex:316; appliedIndex:315; }","duration":"161.270545ms","start":"2026-05-26T20:16:33.558338Z","end":"2026-05-26T20:16:33.719608Z","steps":["trace[1426465730] 'read index received' (duration: 160.831887ms)","trace[1426465730] 'applied index is now lower than readState.Index' (duration: 437.468µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T20:16:33.719821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.37348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5336"} {"level":"info","ts":"2026-05-26T20:16:33.719823Z","caller":"traceutil/trace.go:171","msg":"trace[129394828] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"158.164939ms","start":"2026-05-26T20:16:33.561642Z","end":"2026-05-26T20:16:33.719807Z","steps":["trace[129394828] 'process raft request' (duration: 158.078293ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:16:33.719878Z","caller":"traceutil/trace.go:171","msg":"trace[823692499] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:306; }","duration":"522.467275ms","start":"2026-05-26T20:16:33.197382Z","end":"2026-05-26T20:16:33.719849Z","steps":["trace[823692499] 'agreement among raft nodes before linearized reading' (duration: 522.324806ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:16:33.719935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:16:33.197365Z","time spent":"522.54921ms","remote":"127.0.0.1:54990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":5359,"request content":"key:\"/registry/pods/kube-system/etcd-instance\" "} {"level":"warn","ts":"2026-05-26T20:16:33.720083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.200426ms","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-26T20:16:33.720116Z","caller":"traceutil/trace.go:171","msg":"trace[14785384] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:307; }","duration":"273.287031ms","start":"2026-05-26T20:16:33.446822Z","end":"2026-05-26T20:16:33.720109Z","steps":["trace[14785384] 'agreement among raft nodes before linearized reading' (duration: 273.219706ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:16:33.720177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.114894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5897"} {"level":"info","ts":"2026-05-26T20:16:33.720194Z","caller":"traceutil/trace.go:171","msg":"trace[678151308] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:307; }","duration":"522.205309ms","start":"2026-05-26T20:16:33.197984Z","end":"2026-05-26T20:16:33.720189Z","steps":["trace[678151308] 'agreement among raft nodes before linearized reading' (duration: 522.173997ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:16:33.720196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.964337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:1 size:216"} {"level":"warn","ts":"2026-05-26T20:16:33.720252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:16:33.197932Z","time spent":"522.272384ms","remote":"127.0.0.1:54990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":5920,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"info","ts":"2026-05-26T20:16:33.720286Z","caller":"traceutil/trace.go:171","msg":"trace[1856758512] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:307; }","duration":"520.077223ms","start":"2026-05-26T20:16:33.200188Z","end":"2026-05-26T20:16:33.720266Z","steps":["trace[1856758512] 'agreement among raft nodes before linearized reading' (duration: 519.947125ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:16:33.720253Z","caller":"traceutil/trace.go:171","msg":"trace[84218479] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"502.543003ms","start":"2026-05-26T20:16:33.217654Z","end":"2026-05-26T20:16:33.720197Z","steps":["trace[84218479] 'process raft request' (duration: 501.502148ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:16:33.720335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:16:33.200177Z","time spent":"520.148028ms","remote":"127.0.0.1:55008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":239,"request content":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" "} {"level":"warn","ts":"2026-05-26T20:16:33.720735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:16:33.217636Z","time spent":"502.713705ms","remote":"127.0.0.1:54990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5321,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T20:17:01.657155Z","caller":"traceutil/trace.go:171","msg":"trace[1396869154] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"103.468751ms","start":"2026-05-26T20:17:01.55366Z","end":"2026-05-26T20:17:01.657129Z","steps":["trace[1396869154] 'process raft request' (duration: 103.312838ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:17:01.668087Z","caller":"traceutil/trace.go:171","msg":"trace[695235433] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"112.567905ms","start":"2026-05-26T20:17:01.5555Z","end":"2026-05-26T20:17:01.668068Z","steps":["trace[695235433] 'process raft request' (duration: 112.002823ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:17:01.668559Z","caller":"traceutil/trace.go:171","msg":"trace[1272554133] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"104.66969ms","start":"2026-05-26T20:17:01.563867Z","end":"2026-05-26T20:17:01.668536Z","steps":["trace[1272554133] 'process raft request' (duration: 103.739421ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:17:07.789163Z","caller":"traceutil/trace.go:171","msg":"trace[1714339149] linearizableReadLoop","detail":"{readStateIndex:645; appliedIndex:644; }","duration":"142.081628ms","start":"2026-05-26T20:17:07.647055Z","end":"2026-05-26T20:17:07.789137Z","steps":["trace[1714339149] 'read index received' (duration: 139.853951ms)","trace[1714339149] 'applied index is now lower than readState.Index' (duration: 2.226637ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T20:17:07.789472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.812619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T20:17:07.789567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.552321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T20:17:07.789551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.942819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T20:17:07.789629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.558255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T20:17:07.789665Z","caller":"traceutil/trace.go:171","msg":"trace[1515697970] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:624; }","duration":"142.618209ms","start":"2026-05-26T20:17:07.647037Z","end":"2026-05-26T20:17:07.789655Z","steps":["trace[1515697970] 'agreement among raft nodes before linearized reading' (duration: 142.277233ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:17:07.789652Z","caller":"traceutil/trace.go:171","msg":"trace[1463353406] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:624; }","duration":"122.138215ms","start":"2026-05-26T20:17:07.667497Z","end":"2026-05-26T20:17:07.789636Z","steps":["trace[1463353406] 'agreement among raft nodes before linearized reading' (duration: 121.945839ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:17:07.789558Z","caller":"traceutil/trace.go:171","msg":"trace[83059712] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:624; }","duration":"121.967781ms","start":"2026-05-26T20:17:07.667578Z","end":"2026-05-26T20:17:07.789546Z","steps":["trace[83059712] 'agreement among raft nodes before linearized reading' (duration: 121.82333ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:17:07.789609Z","caller":"traceutil/trace.go:171","msg":"trace[1057998369] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:624; }","duration":"121.609775ms","start":"2026-05-26T20:17:07.667986Z","end":"2026-05-26T20:17:07.789596Z","steps":["trace[1057998369] 'agreement among raft nodes before linearized reading' (duration: 121.547979ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:17:07.789479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.298814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T20:17:07.789961Z","caller":"traceutil/trace.go:171","msg":"trace[12766084] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"142.952925ms","start":"2026-05-26T20:17:07.646308Z","end":"2026-05-26T20:17:07.789261Z","steps":["trace[12766084] 'process raft request' (duration: 140.830985ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:17:07.79002Z","caller":"traceutil/trace.go:171","msg":"trace[410458918] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:624; }","duration":"142.869228ms","start":"2026-05-26T20:17:07.647135Z","end":"2026-05-26T20:17:07.790005Z","steps":["trace[410458918] 'agreement among raft nodes before linearized reading' (duration: 142.254851ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:17:08.066941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.183445ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-26T20:17:08.067037Z","caller":"traceutil/trace.go:171","msg":"trace[1192627447] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:645; }","duration":"180.058137ms","start":"2026-05-26T20:17:07.886966Z","end":"2026-05-26T20:17:08.067024Z","steps":["trace[1192627447] 'read index received' (duration: 69.695µs)","trace[1192627447] 'applied index is now lower than readState.Index' (duration: 179.987592ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T20:17:08.067197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.227329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-26T20:17:08.067125Z","caller":"traceutil/trace.go:171","msg":"trace[942406126] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"223.775834ms","start":"2026-05-26T20:17:07.84331Z","end":"2026-05-26T20:17:08.067086Z","steps":["trace[942406126] 'process raft request' (duration: 32.392413ms)","trace[942406126] 'compare' (duration: 191.056216ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T20:17:08.067224Z","caller":"traceutil/trace.go:171","msg":"trace[1186612031] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:625; }","duration":"180.297235ms","start":"2026-05-26T20:17:07.886919Z","end":"2026-05-26T20:17:08.067216Z","steps":["trace[1186612031] 'agreement among raft nodes before linearized reading' (duration: 180.175926ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:17:08.067354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.193835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-26T20:17:08.067382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.35635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-v5kg5\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-26T20:17:08.067444Z","caller":"traceutil/trace.go:171","msg":"trace[1420207921] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:625; }","duration":"154.311974ms","start":"2026-05-26T20:17:07.913115Z","end":"2026-05-26T20:17:08.067427Z","steps":["trace[1420207921] 'agreement among raft nodes before linearized reading' (duration: 154.074026ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:17:08.067487Z","caller":"traceutil/trace.go:171","msg":"trace[1892546096] range","detail":"{range_begin:/registry/pods/kube-system/cilium-v5kg5; range_end:; response_count:1; response_revision:625; }","duration":"173.526383ms","start":"2026-05-26T20:17:07.89393Z","end":"2026-05-26T20:17:08.067456Z","steps":["trace[1892546096] 'agreement among raft nodes before linearized reading' (duration: 173.235461ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:17:08.45153Z","caller":"traceutil/trace.go:171","msg":"trace[132530942] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:646; }","duration":"374.01316ms","start":"2026-05-26T20:17:08.077473Z","end":"2026-05-26T20:17:08.451486Z","steps":["trace[132530942] 'read index received' (duration: 50.032535ms)","trace[132530942] 'applied index is now lower than readState.Index' (duration: 323.979665ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T20:17:08.451569Z","caller":"traceutil/trace.go:171","msg":"trace[542927877] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"378.690583ms","start":"2026-05-26T20:17:08.072832Z","end":"2026-05-26T20:17:08.451523Z","steps":["trace[542927877] 'process raft request' (duration: 378.559293ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:17:08.451735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:17:08.072824Z","time spent":"378.827293ms","remote":"127.0.0.1:55048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T20:17:08.45194Z","caller":"traceutil/trace.go:171","msg":"trace[1427732790] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"380.128912ms","start":"2026-05-26T20:17:08.071774Z","end":"2026-05-26T20:17:08.451903Z","steps":["trace[1427732790] 'process raft request' (duration: 379.465442ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:17:08.452059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.768586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-26T20:17:08.452078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:17:08.071751Z","time spent":"380.251892ms","remote":"127.0.0.1:55048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T20:17:08.452144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.662759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T20:17:08.452153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.323479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T20:17:08.452185Z","caller":"traceutil/trace.go:171","msg":"trace[1325049552] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:629; }","duration":"274.382664ms","start":"2026-05-26T20:17:08.177793Z","end":"2026-05-26T20:17:08.452176Z","steps":["trace[1325049552] 'agreement among raft nodes before linearized reading' (duration: 274.33617ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:17:08.452188Z","caller":"traceutil/trace.go:171","msg":"trace[944080160] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:629; }","duration":"374.709732ms","start":"2026-05-26T20:17:08.077463Z","end":"2026-05-26T20:17:08.452172Z","steps":["trace[944080160] 'agreement among raft nodes before linearized reading' (duration: 374.628186ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:17:08.452218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:17:08.077432Z","time spent":"374.779657ms","remote":"127.0.0.1:55038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"info","ts":"2026-05-26T20:17:08.452109Z","caller":"traceutil/trace.go:171","msg":"trace[111123060] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:629; }","duration":"287.857243ms","start":"2026-05-26T20:17:08.164239Z","end":"2026-05-26T20:17:08.452096Z","steps":["trace[111123060] 'agreement among raft nodes before linearized reading' (duration: 287.68515ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:17:08.452527Z","caller":"traceutil/trace.go:171","msg":"trace[442326336] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"370.702548ms","start":"2026-05-26T20:17:08.081809Z","end":"2026-05-26T20:17:08.452511Z","steps":["trace[442326336] 'process raft request' (duration: 369.627477ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:17:08.452654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:17:08.081798Z","time spent":"370.775484ms","remote":"127.0.0.1:54990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T20:17:09.204836Z","caller":"traceutil/trace.go:171","msg":"trace[509184065] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:650; }","duration":"405.50704ms","start":"2026-05-26T20:17:08.799301Z","end":"2026-05-26T20:17:09.204808Z","steps":["trace[509184065] 'read index received' (duration: 405.308315ms)","trace[509184065] 'applied index is now lower than readState.Index' (duration: 197.815µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T20:17:09.204964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.643599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T20:17:09.204939Z","caller":"traceutil/trace.go:171","msg":"trace[1386033594] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"748.326479ms","start":"2026-05-26T20:17:08.456573Z","end":"2026-05-26T20:17:09.204899Z","steps":["trace[1386033594] 'process raft request' (duration: 748.092421ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:17:09.205038Z","caller":"traceutil/trace.go:171","msg":"trace[777332509] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:630; }","duration":"405.752948ms","start":"2026-05-26T20:17:08.799268Z","end":"2026-05-26T20:17:09.205021Z","steps":["trace[777332509] 'agreement among raft nodes before linearized reading' (duration: 405.631679ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:17:09.205244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:17:08.456525Z","time spent":"748.6065ms","remote":"127.0.0.1:55048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T20:17:09.205321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:17:08.799254Z","time spent":"406.034999ms","remote":"127.0.0.1:54776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-26T20:17:09.221862Z","caller":"traceutil/trace.go:171","msg":"trace[1188349704] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"360.457085ms","start":"2026-05-26T20:17:08.861305Z","end":"2026-05-26T20:17:09.221762Z","steps":["trace[1188349704] 'process raft request' (duration: 359.290256ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:17:09.222826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:17:08.861289Z","time spent":"361.425278ms","remote":"127.0.0.1:54898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036317,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T20:17:54.549208Z","caller":"traceutil/trace.go:171","msg":"trace[1091233136] transaction","detail":"{read_only:false; response_revision:1198; number_of_response:1; }","duration":"176.374437ms","start":"2026-05-26T20:17:54.372807Z","end":"2026-05-26T20:17:54.549181Z","steps":["trace[1091233136] 'process raft request' (duration: 176.22088ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:18:35.085154Z","caller":"traceutil/trace.go:171","msg":"trace[1792603386] transaction","detail":"{read_only:false; response_revision:1764; number_of_response:1; }","duration":"139.946242ms","start":"2026-05-26T20:18:34.94518Z","end":"2026-05-26T20:18:35.085126Z","steps":["trace[1792603386] 'process raft request' (duration: 81.075032ms)","trace[1792603386] 'compare' (duration: 58.702557ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T20:18:35.085389Z","caller":"traceutil/trace.go:171","msg":"trace[546024200] transaction","detail":"{read_only:false; response_revision:1765; number_of_response:1; }","duration":"138.021305ms","start":"2026-05-26T20:18:34.947331Z","end":"2026-05-26T20:18:35.085353Z","steps":["trace[546024200] 'process raft request' (duration: 137.748009ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:18:41.484263Z","caller":"traceutil/trace.go:171","msg":"trace[908343668] linearizableReadLoop","detail":"{readStateIndex:1942; appliedIndex:1941; }","duration":"112.773041ms","start":"2026-05-26T20:18:41.371466Z","end":"2026-05-26T20:18:41.484239Z","steps":["trace[908343668] 'read index received' (duration: 112.627458ms)","trace[908343668] 'applied index is now lower than readState.Index' (duration: 144.583µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T20:18:41.484319Z","caller":"traceutil/trace.go:171","msg":"trace[1739309798] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"117.908037ms","start":"2026-05-26T20:18:41.366367Z","end":"2026-05-26T20:18:41.484275Z","steps":["trace[1739309798] 'process raft request' (duration: 117.731663ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:18:41.48454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.065149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f1749eaa-802e-421f-992d-2950f90fb3aa\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-26T20:18:41.484608Z","caller":"traceutil/trace.go:171","msg":"trace[1922905218] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f1749eaa-802e-421f-992d-2950f90fb3aa; range_end:; response_count:1; response_revision:1873; }","duration":"113.185982ms","start":"2026-05-26T20:18:41.371405Z","end":"2026-05-26T20:18:41.484591Z","steps":["trace[1922905218] 'agreement among raft nodes before linearized reading' (duration: 112.929936ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:18:42.132467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.073232ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T20:18:42.132819Z","caller":"traceutil/trace.go:171","msg":"trace[2133371628] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"643.524009ms","start":"2026-05-26T20:18:41.489271Z","end":"2026-05-26T20:18:42.132795Z","steps":["trace[2133371628] 'process raft request' (duration: 268.041787ms)","trace[2133371628] 'compare' (duration: 374.954689ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T20:18:42.132857Z","caller":"traceutil/trace.go:171","msg":"trace[725684158] linearizableReadLoop","detail":"{readStateIndex:1945; appliedIndex:1944; }","duration":"643.478646ms","start":"2026-05-26T20:18:41.489366Z","end":"2026-05-26T20:18:42.132844Z","steps":["trace[725684158] 'read index received' (duration: 2.118151ms)","trace[725684158] 'applied index is now lower than readState.Index' (duration: 641.358865ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T20:18:42.132968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:18:41.489258Z","time spent":"643.617831ms","remote":"127.0.0.1:54974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":977,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T20:18:42.133011Z","caller":"traceutil/trace.go:171","msg":"trace[555428666] transaction","detail":"{read_only:false; response_revision:1878; number_of_response:1; }","duration":"641.604852ms","start":"2026-05-26T20:18:41.491385Z","end":"2026-05-26T20:18:42.13299Z","steps":["trace[555428666] 'process raft request' (duration: 641.277484ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:18:42.133088Z","caller":"traceutil/trace.go:171","msg":"trace[880076313] transaction","detail":"{read_only:false; response_revision:1879; number_of_response:1; }","duration":"640.682688ms","start":"2026-05-26T20:18:41.492398Z","end":"2026-05-26T20:18:42.13308Z","steps":["trace[880076313] 'process raft request' (duration: 640.511294ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:18:42.133142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:18:41.492389Z","time spent":"640.727239ms","remote":"127.0.0.1:55062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1529,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T20:18:42.133135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:18:41.491373Z","time spent":"641.703674ms","remote":"127.0.0.1:54974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T20:18:42.133035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"643.660282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f1749eaa-802e-421f-992d-2950f90fb3aa\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-26T20:18:42.133254Z","caller":"traceutil/trace.go:171","msg":"trace[413712580] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f1749eaa-802e-421f-992d-2950f90fb3aa; range_end:; response_count:1; response_revision:1878; }","duration":"643.913447ms","start":"2026-05-26T20:18:41.48933Z","end":"2026-05-26T20:18:42.133243Z","steps":["trace[413712580] 'agreement among raft nodes before linearized reading' (duration: 643.597689ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:18:42.13331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:18:41.489314Z","time spent":"643.985721ms","remote":"127.0.0.1:54990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f1749eaa-802e-421f-992d-2950f90fb3aa\" "} {"level":"info","ts":"2026-05-26T20:18:42.133385Z","caller":"traceutil/trace.go:171","msg":"trace[1579848078] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"641.97717ms","start":"2026-05-26T20:18:41.49073Z","end":"2026-05-26T20:18:42.132707Z","steps":["trace[1579848078] 'process raft request' (duration: 641.827956ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:18:42.133465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:18:41.490704Z","time spent":"642.730149ms","remote":"127.0.0.1:55062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1471,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T20:18:42.135399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.499172ms","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-26T20:18:42.135445Z","caller":"traceutil/trace.go:171","msg":"trace[1394007875] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1879; }","duration":"508.627455ms","start":"2026-05-26T20:18:41.626804Z","end":"2026-05-26T20:18:42.135432Z","steps":["trace[1394007875] 'agreement among raft nodes before linearized reading' (duration: 508.493881ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:18:42.135476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:18:41.626787Z","time spent":"508.682137ms","remote":"127.0.0.1:55048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-26T20:18:42.135666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.429041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T20:18:42.135702Z","caller":"traceutil/trace.go:171","msg":"trace[1309699688] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1879; }","duration":"145.500393ms","start":"2026-05-26T20:18:41.990192Z","end":"2026-05-26T20:18:42.135693Z","steps":["trace[1309699688] 'agreement among raft nodes before linearized reading' (duration: 145.430301ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:18:42.135879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.742711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-26T20:18:42.135924Z","caller":"traceutil/trace.go:171","msg":"trace[367751007] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1879; }","duration":"290.808314ms","start":"2026-05-26T20:18:41.845098Z","end":"2026-05-26T20:18:42.135906Z","steps":["trace[367751007] 'agreement among raft nodes before linearized reading' (duration: 290.721202ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:18:42.13662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.835787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T20:18:42.136714Z","caller":"traceutil/trace.go:171","msg":"trace[152079918] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1879; }","duration":"367.94671ms","start":"2026-05-26T20:18:41.768746Z","end":"2026-05-26T20:18:42.136693Z","steps":["trace[152079918] 'agreement among raft nodes before linearized reading' (duration: 367.753185ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:18:42.136894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:18:41.768695Z","time spent":"368.183796ms","remote":"127.0.0.1:42008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-05-26T20:18:42.673235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.210299ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T20:18:42.673638Z","caller":"traceutil/trace.go:171","msg":"trace[1604584193] transaction","detail":"{read_only:false; response_revision:1881; number_of_response:1; }","duration":"532.468875ms","start":"2026-05-26T20:18:42.141147Z","end":"2026-05-26T20:18:42.673616Z","steps":["trace[1604584193] 'process raft request' (duration: 171.752253ms)","trace[1604584193] 'compare' (duration: 359.873711ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T20:18:42.67373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:18:42.141129Z","time spent":"532.553948ms","remote":"127.0.0.1:54990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3729,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T20:18:42.67364Z","caller":"traceutil/trace.go:171","msg":"trace[393127722] linearizableReadLoop","detail":"{readStateIndex:1950; appliedIndex:1948; }","duration":"495.683427ms","start":"2026-05-26T20:18:42.177915Z","end":"2026-05-26T20:18:42.673598Z","steps":["trace[393127722] 'read index received' (duration: 7.179452ms)","trace[393127722] 'applied index is now lower than readState.Index' (duration: 488.501295ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T20:18:42.673916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.997395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T20:18:42.674064Z","caller":"traceutil/trace.go:171","msg":"trace[535160705] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1881; }","duration":"496.18035ms","start":"2026-05-26T20:18:42.177866Z","end":"2026-05-26T20:18:42.674046Z","steps":["trace[535160705] 'agreement among raft nodes before linearized reading' (duration: 495.988515ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:18:42.674114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:18:42.177846Z","time spent":"496.254031ms","remote":"127.0.0.1:54776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-26T20:18:42.696907Z","caller":"traceutil/trace.go:171","msg":"trace[904841342] transaction","detail":"{read_only:false; response_revision:1882; number_of_response:1; }","duration":"331.739351ms","start":"2026-05-26T20:18:42.365149Z","end":"2026-05-26T20:18:42.696888Z","steps":["trace[904841342] 'process raft request' (duration: 331.634368ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:18:42.697005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:18:42.365125Z","time spent":"331.828713ms","remote":"127.0.0.1:55048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T20:18:42.699246Z","caller":"traceutil/trace.go:171","msg":"trace[1180688597] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"247.610207ms","start":"2026-05-26T20:18:42.451612Z","end":"2026-05-26T20:18:42.699222Z","steps":["trace[1180688597] 'process raft request' (duration: 247.445723ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:18:42.699638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.692701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f1749eaa-802e-421f-992d-2950f90fb3aa\" ","response":"range_response_count:1 size:3744"} {"level":"info","ts":"2026-05-26T20:18:42.699738Z","caller":"traceutil/trace.go:171","msg":"trace[1193799090] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f1749eaa-802e-421f-992d-2950f90fb3aa; range_end:; response_count:1; response_revision:1884; }","duration":"209.838985ms","start":"2026-05-26T20:18:42.489877Z","end":"2026-05-26T20:18:42.699716Z","steps":["trace[1193799090] 'agreement among raft nodes before linearized reading' (duration: 209.668761ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:18:59.339734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.439561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-26T20:18:59.339825Z","caller":"traceutil/trace.go:171","msg":"trace[2142952717] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2016; }","duration":"439.567856ms","start":"2026-05-26T20:18:58.900227Z","end":"2026-05-26T20:18:59.339795Z","steps":["trace[2142952717] 'range keys from in-memory index tree' (duration: 439.283086ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:18:59.339864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:18:58.900208Z","time spent":"439.64782ms","remote":"127.0.0.1:55048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-26T20:18:59.340141Z","caller":"traceutil/trace.go:171","msg":"trace[1850999745] linearizableReadLoop","detail":"{readStateIndex:2090; appliedIndex:2089; }","duration":"285.656283ms","start":"2026-05-26T20:18:59.054461Z","end":"2026-05-26T20:18:59.340118Z","steps":["trace[1850999745] 'read index received' (duration: 284.605266ms)","trace[1850999745] 'applied index is now lower than readState.Index' (duration: 1.049897ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T20:18:59.340223Z","caller":"traceutil/trace.go:171","msg":"trace[148584249] transaction","detail":"{read_only:false; response_revision:2017; number_of_response:1; }","duration":"326.746922ms","start":"2026-05-26T20:18:59.013463Z","end":"2026-05-26T20:18:59.34021Z","steps":["trace[148584249] 'process raft request' (duration: 325.499117ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:18:59.340307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:18:59.013444Z","time spent":"326.809194ms","remote":"127.0.0.1:55048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T20:18:59.340348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.869522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-26T20:18:59.340378Z","caller":"traceutil/trace.go:171","msg":"trace[147366238] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2017; }","duration":"285.942044ms","start":"2026-05-26T20:18:59.054426Z","end":"2026-05-26T20:18:59.340368Z","steps":["trace[147366238] 'agreement among raft nodes before linearized reading' (duration: 285.807459ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:18:59.340505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.622245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T20:18:59.340552Z","caller":"traceutil/trace.go:171","msg":"trace[2043320852] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2017; }","duration":"161.687407ms","start":"2026-05-26T20:18:59.178853Z","end":"2026-05-26T20:18:59.34054Z","steps":["trace[2043320852] 'agreement among raft nodes before linearized reading' (duration: 161.627625ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:18:59.34069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.954406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-26T20:18:59.340722Z","caller":"traceutil/trace.go:171","msg":"trace[1031397544] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2017; }","duration":"146.025109ms","start":"2026-05-26T20:18:59.194691Z","end":"2026-05-26T20:18:59.340716Z","steps":["trace[1031397544] 'agreement among raft nodes before linearized reading' (duration: 145.946616ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:18:59.340738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.727679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-26T20:18:59.340767Z","caller":"traceutil/trace.go:171","msg":"trace[1348836683] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2017; }","duration":"155.768721ms","start":"2026-05-26T20:18:59.18499Z","end":"2026-05-26T20:18:59.340759Z","steps":["trace[1348836683] 'agreement among raft nodes before linearized reading' (duration: 155.686558ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:19:22.394532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.875839ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T20:19:22.394887Z","caller":"traceutil/trace.go:171","msg":"trace[208109108] linearizableReadLoop","detail":"{readStateIndex:2226; appliedIndex:2225; }","duration":"217.638785ms","start":"2026-05-26T20:19:22.177223Z","end":"2026-05-26T20:19:22.394861Z","steps":["trace[208109108] 'read index received' (duration: 31.092µs)","trace[208109108] 'applied index is now lower than readState.Index' (duration: 217.605153ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T20:19:22.394935Z","caller":"traceutil/trace.go:171","msg":"trace[159442422] transaction","detail":"{read_only:false; response_revision:2148; number_of_response:1; }","duration":"533.682974ms","start":"2026-05-26T20:19:21.861177Z","end":"2026-05-26T20:19:22.39486Z","steps":["trace[159442422] 'process raft request' (duration: 114.363086ms)","trace[159442422] 'compare' (duration: 418.68739ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T20:19:22.395236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:19:21.861147Z","time spent":"533.955316ms","remote":"127.0.0.1:55048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T20:19:22.395604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.20937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T20:19:22.395693Z","caller":"traceutil/trace.go:171","msg":"trace[1339039168] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2149; }","duration":"218.486923ms","start":"2026-05-26T20:19:22.177187Z","end":"2026-05-26T20:19:22.395674Z","steps":["trace[1339039168] 'agreement among raft nodes before linearized reading' (duration: 217.879335ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:19:22.577947Z","caller":"traceutil/trace.go:171","msg":"trace[1345864556] transaction","detail":"{read_only:false; response_revision:2150; number_of_response:1; }","duration":"177.530776ms","start":"2026-05-26T20:19:22.400371Z","end":"2026-05-26T20:19:22.577901Z","steps":["trace[1345864556] 'process raft request' (duration: 151.738504ms)","trace[1345864556] 'compare' (duration: 25.310289ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T20:19:23.05443Z","caller":"traceutil/trace.go:171","msg":"trace[506985410] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"140.662848ms","start":"2026-05-26T20:19:22.913741Z","end":"2026-05-26T20:19:23.054404Z","steps":["trace[506985410] 'process raft request' (duration: 140.461529ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:19:23.054969Z","caller":"traceutil/trace.go:171","msg":"trace[57385872] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"141.142738ms","start":"2026-05-26T20:19:22.913802Z","end":"2026-05-26T20:19:23.054945Z","steps":["trace[57385872] 'process raft request' (duration: 141.028473ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:20:12.151533Z","caller":"traceutil/trace.go:171","msg":"trace[814398614] transaction","detail":"{read_only:false; response_revision:2524; number_of_response:1; }","duration":"348.619422ms","start":"2026-05-26T20:20:11.802895Z","end":"2026-05-26T20:20:12.151515Z","steps":["trace[814398614] 'process raft request' (duration: 329.394502ms)","trace[814398614] 'compare' (duration: 18.907422ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T20:20:12.151518Z","caller":"traceutil/trace.go:171","msg":"trace[398403963] linearizableReadLoop","detail":"{readStateIndex:2615; appliedIndex:2613; }","duration":"267.047851ms","start":"2026-05-26T20:20:11.884444Z","end":"2026-05-26T20:20:12.151492Z","steps":["trace[398403963] 'read index received' (duration: 248.057235ms)","trace[398403963] 'applied index is now lower than readState.Index' (duration: 18.989466ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T20:20:12.151637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:20:11.802884Z","time spent":"348.699157ms","remote":"127.0.0.1:55048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T20:20:12.15155Z","caller":"traceutil/trace.go:171","msg":"trace[838898791] transaction","detail":"{read_only:false; response_revision:2525; number_of_response:1; }","duration":"267.852087ms","start":"2026-05-26T20:20:11.883667Z","end":"2026-05-26T20:20:12.151519Z","steps":["trace[838898791] 'process raft request' (duration: 267.770792ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:20:12.151772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.303895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-05-26T20:20:12.151863Z","caller":"traceutil/trace.go:171","msg":"trace[1147639756] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2525; }","duration":"267.442343ms","start":"2026-05-26T20:20:11.884401Z","end":"2026-05-26T20:20:12.151844Z","steps":["trace[1147639756] 'agreement among raft nodes before linearized reading' (duration: 267.188969ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:20:45.521239Z","caller":"traceutil/trace.go:171","msg":"trace[1883463854] transaction","detail":"{read_only:false; response_revision:2707; number_of_response:1; }","duration":"260.711756ms","start":"2026-05-26T20:20:45.260385Z","end":"2026-05-26T20:20:45.521097Z","steps":["trace[1883463854] 'process raft request' (duration: 215.207559ms)","trace[1883463854] 'compare' (duration: 45.296134ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T20:20:45.5513Z","caller":"traceutil/trace.go:171","msg":"trace[576694013] transaction","detail":"{read_only:false; response_revision:2708; number_of_response:1; }","duration":"215.931683ms","start":"2026-05-26T20:20:45.335348Z","end":"2026-05-26T20:20:45.551279Z","steps":["trace[576694013] 'process raft request' (duration: 215.757693ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:20:45.55175Z","caller":"traceutil/trace.go:171","msg":"trace[2122614745] transaction","detail":"{read_only:false; response_revision:2709; number_of_response:1; }","duration":"216.314068ms","start":"2026-05-26T20:20:45.33541Z","end":"2026-05-26T20:20:45.551724Z","steps":["trace[2122614745] 'process raft request' (duration: 215.820417ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:20:45.785392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.895033ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-26T20:20:45.785505Z","caller":"traceutil/trace.go:171","msg":"trace[901577248] linearizableReadLoop","detail":"{readStateIndex:2807; appliedIndex:2806; }","duration":"185.587618ms","start":"2026-05-26T20:20:45.599899Z","end":"2026-05-26T20:20:45.785486Z","steps":["trace[901577248] 'read index received' (duration: 88.475µs)","trace[901577248] 'applied index is now lower than readState.Index' (duration: 185.497833ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T20:20:45.785593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.685784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T20:20:45.785633Z","caller":"traceutil/trace.go:171","msg":"trace[1059273875] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:2709; }","duration":"185.739567ms","start":"2026-05-26T20:20:45.599881Z","end":"2026-05-26T20:20:45.785621Z","steps":["trace[1059273875] 'agreement among raft nodes before linearized reading' (duration: 185.651951ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:24:30.597038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.531834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T20:24:30.597192Z","caller":"traceutil/trace.go:171","msg":"trace[2127509690] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4669; }","duration":"418.73707ms","start":"2026-05-26T20:24:30.178436Z","end":"2026-05-26T20:24:30.597173Z","steps":["trace[2127509690] 'range keys from in-memory index tree' (duration: 418.446162ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:24:30.597093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.102362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-26T20:24:30.597226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.776935ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T20:24:30.597281Z","caller":"traceutil/trace.go:171","msg":"trace[392729757] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4669; }","duration":"417.323128ms","start":"2026-05-26T20:24:30.179938Z","end":"2026-05-26T20:24:30.597261Z","steps":["trace[392729757] 'range keys from in-memory index tree' (duration: 416.933057ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:24:30.597303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:24:30.178415Z","time spent":"418.835523ms","remote":"127.0.0.1:54776","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-26T20:24:30.597336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:24:30.179919Z","time spent":"417.404881ms","remote":"127.0.0.1:55048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-26T20:24:30.597455Z","caller":"traceutil/trace.go:171","msg":"trace[1684942972] transaction","detail":"{read_only:false; response_revision:4671; number_of_response:1; }","duration":"266.615981ms","start":"2026-05-26T20:24:30.330822Z","end":"2026-05-26T20:24:30.597438Z","steps":["trace[1684942972] 'process raft request' (duration: 266.514958ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:24:30.597081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.167259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.132\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-26T20:24:30.59751Z","caller":"traceutil/trace.go:171","msg":"trace[68048564] transaction","detail":"{read_only:false; response_revision:4670; number_of_response:1; }","duration":"340.958186ms","start":"2026-05-26T20:24:30.256528Z","end":"2026-05-26T20:24:30.597486Z","steps":["trace[68048564] 'process raft request' (duration: 55.81663ms)","trace[68048564] 'compare' (duration: 284.457136ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T20:24:30.597543Z","caller":"traceutil/trace.go:171","msg":"trace[1080793106] range","detail":"{range_begin:/registry/masterleases/199.204.45.132; range_end:; response_count:1; response_revision:4669; }","duration":"352.619842ms","start":"2026-05-26T20:24:30.244884Z","end":"2026-05-26T20:24:30.597504Z","steps":["trace[1080793106] 'range keys from in-memory index tree' (duration: 351.930033ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:24:30.597612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:24:30.256511Z","time spent":"341.053719ms","remote":"127.0.0.1:55048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T20:24:30.597623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:24:30.244823Z","time spent":"352.754246ms","remote":"127.0.0.1:54830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.132\" "} {"level":"info","ts":"2026-05-26T20:24:30.604155Z","caller":"traceutil/trace.go:171","msg":"trace[530841378] transaction","detail":"{read_only:false; response_revision:4672; number_of_response:1; }","duration":"270.75825ms","start":"2026-05-26T20:24:30.333386Z","end":"2026-05-26T20:24:30.604144Z","steps":["trace[530841378] 'process raft request' (duration: 270.646057ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:24:30.604293Z","caller":"traceutil/trace.go:171","msg":"trace[1508504268] linearizableReadLoop","detail":"{readStateIndex:4839; appliedIndex:4836; }","duration":"165.169584ms","start":"2026-05-26T20:24:30.439113Z","end":"2026-05-26T20:24:30.604283Z","steps":["trace[1508504268] 'read index received' (duration: 132.465272ms)","trace[1508504268] 'applied index is now lower than readState.Index' (duration: 32.703332ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T20:24:30.604417Z","caller":"traceutil/trace.go:171","msg":"trace[1712849085] transaction","detail":"{read_only:false; response_revision:4673; number_of_response:1; }","duration":"113.624977ms","start":"2026-05-26T20:24:30.490692Z","end":"2026-05-26T20:24:30.604317Z","steps":["trace[1712849085] 'process raft request' (duration: 113.406431ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:24:30.604444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.3367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-32380e71-8c47-4786-8b34-963ce4b619fb\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-05-26T20:24:30.604474Z","caller":"traceutil/trace.go:171","msg":"trace[1165474820] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-32380e71-8c47-4786-8b34-963ce4b619fb; range_end:; response_count:1; response_revision:4673; }","duration":"165.409592ms","start":"2026-05-26T20:24:30.439058Z","end":"2026-05-26T20:24:30.604468Z","steps":["trace[1165474820] 'agreement among raft nodes before linearized reading' (duration: 165.296058ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:24:31.218165Z","caller":"traceutil/trace.go:171","msg":"trace[29562917] transaction","detail":"{read_only:false; response_revision:4680; number_of_response:1; }","duration":"139.181084ms","start":"2026-05-26T20:24:31.078956Z","end":"2026-05-26T20:24:31.218137Z","steps":["trace[29562917] 'process raft request' (duration: 139.06408ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:24:31.218196Z","caller":"traceutil/trace.go:171","msg":"trace[1887841479] linearizableReadLoop","detail":"{readStateIndex:4848; appliedIndex:4848; }","duration":"135.59766ms","start":"2026-05-26T20:24:31.082552Z","end":"2026-05-26T20:24:31.218149Z","steps":["trace[1887841479] 'read index received' (duration: 135.58604ms)","trace[1887841479] 'applied index is now lower than readState.Index' (duration: 9.51µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T20:24:31.218555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.968091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12975"} {"level":"info","ts":"2026-05-26T20:24:31.218679Z","caller":"traceutil/trace.go:171","msg":"trace[1121083436] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4680; }","duration":"136.124995ms","start":"2026-05-26T20:24:31.082535Z","end":"2026-05-26T20:24:31.21866Z","steps":["trace[1121083436] 'agreement among raft nodes before linearized reading' (duration: 135.748794ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:24:31.223432Z","caller":"traceutil/trace.go:171","msg":"trace[1532300936] transaction","detail":"{read_only:false; response_revision:4681; number_of_response:1; }","duration":"138.545515ms","start":"2026-05-26T20:24:31.08487Z","end":"2026-05-26T20:24:31.223415Z","steps":["trace[1532300936] 'process raft request' (duration: 138.249696ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:24:31.370653Z","caller":"traceutil/trace.go:171","msg":"trace[603236683] linearizableReadLoop","detail":"{readStateIndex:4853; appliedIndex:4852; }","duration":"130.392769ms","start":"2026-05-26T20:24:31.240239Z","end":"2026-05-26T20:24:31.370632Z","steps":["trace[603236683] 'read index received' (duration: 127.222067ms)","trace[603236683] 'applied index is now lower than readState.Index' (duration: 3.169542ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T20:24:31.370859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.600615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-59b007a5-be63-4832-8399-243c57ae30d5\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-05-26T20:24:31.370898Z","caller":"traceutil/trace.go:171","msg":"trace[1287214135] range","detail":"{range_begin:/registry/persistentvolumes/pvc-59b007a5-be63-4832-8399-243c57ae30d5; range_end:; response_count:1; response_revision:4685; }","duration":"130.663946ms","start":"2026-05-26T20:24:31.240223Z","end":"2026-05-26T20:24:31.370887Z","steps":["trace[1287214135] 'agreement among raft nodes before linearized reading' (duration: 130.502642ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:24:31.371169Z","caller":"traceutil/trace.go:171","msg":"trace[1608635241] transaction","detail":"{read_only:false; response_revision:4685; number_of_response:1; }","duration":"140.944795ms","start":"2026-05-26T20:24:31.230214Z","end":"2026-05-26T20:24:31.371158Z","steps":["trace[1608635241] 'process raft request' (duration: 137.31476ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:24:39.026878Z","caller":"traceutil/trace.go:171","msg":"trace[1880125616] transaction","detail":"{read_only:false; response_revision:4803; number_of_response:1; }","duration":"143.950248ms","start":"2026-05-26T20:24:38.882902Z","end":"2026-05-26T20:24:39.026853Z","steps":["trace[1880125616] 'process raft request' (duration: 143.800493ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:24:44.00712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.061414ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T20:24:44.007228Z","caller":"traceutil/trace.go:171","msg":"trace[1698654483] linearizableReadLoop","detail":"{readStateIndex:5027; appliedIndex:5026; }","duration":"746.865289ms","start":"2026-05-26T20:24:43.260344Z","end":"2026-05-26T20:24:44.007209Z","steps":["trace[1698654483] 'read index received' (duration: 433.591159ms)","trace[1698654483] 'applied index is now lower than readState.Index' (duration: 313.27268ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T20:24:44.007318Z","caller":"traceutil/trace.go:171","msg":"trace[73709527] transaction","detail":"{read_only:false; response_revision:4853; number_of_response:1; }","duration":"752.468215ms","start":"2026-05-26T20:24:43.254839Z","end":"2026-05-26T20:24:44.007307Z","steps":["trace[73709527] 'process raft request' (duration: 439.124783ms)","trace[73709527] 'compare' (duration: 312.575038ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T20:24:44.007377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:24:43.25483Z","time spent":"752.514226ms","remote":"127.0.0.1:54990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13649,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T20:24:44.008089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"747.720655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-05-26T20:24:44.008173Z","caller":"traceutil/trace.go:171","msg":"trace[236449642] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4853; }","duration":"747.810258ms","start":"2026-05-26T20:24:43.260339Z","end":"2026-05-26T20:24:44.008149Z","steps":["trace[236449642] 'agreement among raft nodes before linearized reading' (duration: 747.014703ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:24:44.008215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:24:43.26033Z","time spent":"747.8748ms","remote":"127.0.0.1:54966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1958,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"warn","ts":"2026-05-26T20:24:44.008742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"738.32992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-26T20:24:44.008816Z","caller":"traceutil/trace.go:171","msg":"trace[754720463] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4853; }","duration":"738.435123ms","start":"2026-05-26T20:24:43.270365Z","end":"2026-05-26T20:24:44.0088Z","steps":["trace[754720463] 'agreement among raft nodes before linearized reading' (duration: 738.192796ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:24:44.00883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"726.564851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-05-26T20:24:44.008858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:24:43.270357Z","time spent":"738.492865ms","remote":"127.0.0.1:55048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-26T20:24:44.008889Z","caller":"traceutil/trace.go:171","msg":"trace[1804724613] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4853; }","duration":"726.662324ms","start":"2026-05-26T20:24:43.282214Z","end":"2026-05-26T20:24:44.008876Z","steps":["trace[1804724613] 'agreement among raft nodes before linearized reading' (duration: 726.514979ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:24:44.008929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:24:43.282187Z","time spent":"726.734646ms","remote":"127.0.0.1:55048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-26T20:24:44.009067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.62178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-26T20:24:44.0091Z","caller":"traceutil/trace.go:171","msg":"trace[559844399] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4853; }","duration":"546.690972ms","start":"2026-05-26T20:24:43.462401Z","end":"2026-05-26T20:24:44.009092Z","steps":["trace[559844399] 'agreement among raft nodes before linearized reading' (duration: 546.601469ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:24:44.009125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:24:43.462379Z","time spent":"546.740092ms","remote":"127.0.0.1:55048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-26T20:24:44.009136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"729.937517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-26T20:24:44.009174Z","caller":"traceutil/trace.go:171","msg":"trace[890589384] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4853; }","duration":"729.974508ms","start":"2026-05-26T20:24:43.27919Z","end":"2026-05-26T20:24:44.009165Z","steps":["trace[890589384] 'agreement among raft nodes before linearized reading' (duration: 729.884735ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:24:44.009201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:24:43.279147Z","time spent":"730.04829ms","remote":"127.0.0.1:55048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-26T20:24:44.009285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"737.911529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T20:24:44.00931Z","caller":"traceutil/trace.go:171","msg":"trace[68343320] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4853; }","duration":"737.96372ms","start":"2026-05-26T20:24:43.271339Z","end":"2026-05-26T20:24:44.009302Z","steps":["trace[68343320] 'agreement among raft nodes before linearized reading' (duration: 737.926688ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:24:44.009334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:24:43.271323Z","time spent":"738.005931ms","remote":"127.0.0.1:55246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-05-26T20:24:44.278265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.495179ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T20:24:44.278893Z","caller":"traceutil/trace.go:171","msg":"trace[630753462] transaction","detail":"{read_only:false; response_revision:4855; number_of_response:1; }","duration":"263.064162ms","start":"2026-05-26T20:24:44.015799Z","end":"2026-05-26T20:24:44.278864Z","steps":["trace[630753462] 'process raft request' (duration: 114.89513ms)","trace[630753462] 'compare' (duration: 147.388636ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T20:24:44.278931Z","caller":"traceutil/trace.go:171","msg":"trace[573773861] linearizableReadLoop","detail":"{readStateIndex:5036; appliedIndex:5028; }","duration":"204.15419ms","start":"2026-05-26T20:24:44.07476Z","end":"2026-05-26T20:24:44.278915Z","steps":["trace[573773861] 'read index received' (duration: 55.866025ms)","trace[573773861] 'applied index is now lower than readState.Index' (duration: 148.287295ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T20:24:44.279002Z","caller":"traceutil/trace.go:171","msg":"trace[1957433058] transaction","detail":"{read_only:false; response_revision:4861; number_of_response:1; }","duration":"261.843763ms","start":"2026-05-26T20:24:44.017134Z","end":"2026-05-26T20:24:44.278978Z","steps":["trace[1957433058] 'process raft request' (duration: 261.656427ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:24:44.279047Z","caller":"traceutil/trace.go:171","msg":"trace[1572822948] transaction","detail":"{read_only:false; response_revision:4860; number_of_response:1; }","duration":"261.968057ms","start":"2026-05-26T20:24:44.017067Z","end":"2026-05-26T20:24:44.279035Z","steps":["trace[1572822948] 'process raft request' (duration: 261.689958ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:24:44.279077Z","caller":"traceutil/trace.go:171","msg":"trace[1602877145] transaction","detail":"{read_only:false; response_revision:4859; number_of_response:1; }","duration":"262.567296ms","start":"2026-05-26T20:24:44.016397Z","end":"2026-05-26T20:24:44.278964Z","steps":["trace[1602877145] 'process raft request' (duration: 262.327058ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:24:44.27902Z","caller":"traceutil/trace.go:171","msg":"trace[1020556021] transaction","detail":"{read_only:false; response_revision:4862; number_of_response:1; }","duration":"256.328529ms","start":"2026-05-26T20:24:44.022676Z","end":"2026-05-26T20:24:44.279005Z","steps":["trace[1020556021] 'process raft request' (duration: 256.157054ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:24:44.2793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.29587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-05-26T20:24:44.27937Z","caller":"traceutil/trace.go:171","msg":"trace[1550290875] transaction","detail":"{read_only:false; response_revision:4857; number_of_response:1; }","duration":"263.456044ms","start":"2026-05-26T20:24:44.015895Z","end":"2026-05-26T20:24:44.279351Z","steps":["trace[1550290875] 'process raft request' (duration: 262.550456ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:24:44.279425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.833084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-05-26T20:24:44.279469Z","caller":"traceutil/trace.go:171","msg":"trace[851414892] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4863; }","duration":"143.912626ms","start":"2026-05-26T20:24:44.135546Z","end":"2026-05-26T20:24:44.279458Z","steps":["trace[851414892] 'agreement among raft nodes before linearized reading' (duration: 143.793663ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:24:44.279375Z","caller":"traceutil/trace.go:171","msg":"trace[32103231] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4863; }","duration":"201.409483ms","start":"2026-05-26T20:24:44.077952Z","end":"2026-05-26T20:24:44.279361Z","steps":["trace[32103231] 'agreement among raft nodes before linearized reading' (duration: 201.175236ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:24:44.279553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.070235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T20:24:44.279539Z","caller":"traceutil/trace.go:171","msg":"trace[901907504] transaction","detail":"{read_only:false; response_revision:4856; number_of_response:1; }","duration":"262.989939ms","start":"2026-05-26T20:24:44.015844Z","end":"2026-05-26T20:24:44.278834Z","steps":["trace[901907504] 'process raft request' (duration: 262.516004ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:24:44.279383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.873315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-05-26T20:24:44.279782Z","caller":"traceutil/trace.go:171","msg":"trace[847540646] transaction","detail":"{read_only:false; response_revision:4858; number_of_response:1; }","duration":"263.713922ms","start":"2026-05-26T20:24:44.015995Z","end":"2026-05-26T20:24:44.279709Z","steps":["trace[847540646] 'process raft request' (duration: 262.68871ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:24:44.279616Z","caller":"traceutil/trace.go:171","msg":"trace[1778033455] transaction","detail":"{read_only:false; response_revision:4863; number_of_response:1; }","duration":"142.827452ms","start":"2026-05-26T20:24:44.136778Z","end":"2026-05-26T20:24:44.279605Z","steps":["trace[1778033455] 'process raft request' (duration: 142.102439ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:24:44.279784Z","caller":"traceutil/trace.go:171","msg":"trace[1720921182] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4863; }","duration":"262.231355ms","start":"2026-05-26T20:24:44.017479Z","end":"2026-05-26T20:24:44.27971Z","steps":["trace[1720921182] 'agreement among raft nodes before linearized reading' (duration: 261.528643ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:24:44.279628Z","caller":"traceutil/trace.go:171","msg":"trace[368354085] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:4863; }","duration":"171.262761ms","start":"2026-05-26T20:24:44.108354Z","end":"2026-05-26T20:24:44.279617Z","steps":["trace[368354085] 'agreement among raft nodes before linearized reading' (duration: 171.046855ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:24:44.875757Z","caller":"traceutil/trace.go:171","msg":"trace[951842624] transaction","detail":"{read_only:false; response_revision:4867; number_of_response:1; }","duration":"194.502556ms","start":"2026-05-26T20:24:44.681224Z","end":"2026-05-26T20:24:44.875727Z","steps":["trace[951842624] 'process raft request' (duration: 173.816822ms)","trace[951842624] 'compare' (duration: 20.5569ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T20:26:27.447832Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2929} {"level":"info","ts":"2026-05-26T20:26:27.532441Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2929,"took":"82.826223ms","hash":1120356367,"current-db-size-bytes":54337536,"current-db-size":"54 MB","current-db-size-in-use-bytes":29638656,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-26T20:26:27.532521Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1120356367,"revision":2929,"compact-revision":-1} {"level":"warn","ts":"2026-05-26T20:28:26.281675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.538633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T20:28:26.28184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.798964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T20:28:26.281905Z","caller":"traceutil/trace.go:171","msg":"trace[211402256] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:6453; }","duration":"101.902519ms","start":"2026-05-26T20:28:26.179983Z","end":"2026-05-26T20:28:26.281886Z","steps":["trace[211402256] 'count revisions from in-memory index tree' (duration: 101.710209ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:28:26.283478Z","caller":"traceutil/trace.go:171","msg":"trace[1049033605] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6453; }","duration":"104.684101ms","start":"2026-05-26T20:28:26.177064Z","end":"2026-05-26T20:28:26.281748Z","steps":["trace[1049033605] 'range keys from in-memory index tree' (duration: 104.400336ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:31:27.45476Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5649} {"level":"info","ts":"2026-05-26T20:31:27.563561Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5649,"took":"107.480432ms","hash":2239870219,"current-db-size-bytes":54337536,"current-db-size":"54 MB","current-db-size-in-use-bytes":18264064,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-26T20:31:27.563631Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2239870219,"revision":5649,"compact-revision":2929} {"level":"info","ts":"2026-05-26T20:36:27.461044Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7450} {"level":"info","ts":"2026-05-26T20:36:27.516243Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7450,"took":"53.673293ms","hash":10452305,"current-db-size-bytes":54337536,"current-db-size":"54 MB","current-db-size-in-use-bytes":14942208,"current-db-size-in-use":"15 MB"} {"level":"info","ts":"2026-05-26T20:36:27.516312Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":10452305,"revision":7450,"compact-revision":5649} {"level":"warn","ts":"2026-05-26T20:37:35.906269Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256879339389605916,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-26T20:37:36.407062Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256879339389605916,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-26T20:37:36.90725Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256879339389605916,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-26T20:37:37.407626Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256879339389605916,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-26T20:37:37.908636Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256879339389605916,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-26T20:37:38.17769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000377305s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-26T20:37:38.177782Z","caller":"traceutil/trace.go:171","msg":"trace[1912201813] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000561661s","start":"2026-05-26T20:37:36.177197Z","end":"2026-05-26T20:37:38.177759Z","steps":["trace[1912201813] 'agreement among raft nodes before linearized reading' (duration: 2.000411795s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:37:38.177835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:37:36.177175Z","time spent":"2.000648014s","remote":"127.0.0.1:54776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/26 20:37:38 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-26T20:37:38.409226Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":256879339389605916,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-26T20:37:38.666536Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.422407741s","expected-duration":"1s"} {"level":"info","ts":"2026-05-26T20:37:38.667139Z","caller":"traceutil/trace.go:171","msg":"trace[1141830828] transaction","detail":"{read_only:false; response_revision:9309; number_of_response:1; }","duration":"3.423079965s","start":"2026-05-26T20:37:35.244036Z","end":"2026-05-26T20:37:38.667116Z","steps":["trace[1141830828] 'process raft request' (duration: 3.422823746s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:37:38.66728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:37:35.244019Z","time spent":"3.423187239s","remote":"127.0.0.1:55048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T20:37:39.004601Z","caller":"traceutil/trace.go:171","msg":"trace[2043286064] transaction","detail":"{read_only:false; response_revision:9310; number_of_response:1; }","duration":"3.64645034s","start":"2026-05-26T20:37:35.358116Z","end":"2026-05-26T20:37:39.004567Z","steps":["trace[2043286064] 'process raft request' (duration: 3.646196001s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:37:39.004751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:37:35.358094Z","time spent":"3.646582385s","remote":"127.0.0.1:55048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T20:37:39.060599Z","caller":"traceutil/trace.go:171","msg":"trace[419160066] transaction","detail":"{read_only:false; response_revision:9311; number_of_response:1; }","duration":"3.335961793s","start":"2026-05-26T20:37:35.724616Z","end":"2026-05-26T20:37:39.060578Z","steps":["trace[419160066] 'process raft request' (duration: 3.335782337s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:37:39.060758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:37:35.724596Z","time spent":"3.336074458s","remote":"127.0.0.1:55048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T20:37:39.060767Z","caller":"traceutil/trace.go:171","msg":"trace[1493946540] transaction","detail":"{read_only:false; response_revision:9312; number_of_response:1; }","duration":"2.43175796s","start":"2026-05-26T20:37:36.628977Z","end":"2026-05-26T20:37:39.060735Z","steps":["trace[1493946540] 'process raft request' (duration: 2.431558983s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:37:39.060902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:37:36.628963Z","time spent":"2.431862694s","remote":"127.0.0.1:55048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T20:37:39.060975Z","caller":"traceutil/trace.go:171","msg":"trace[1723986828] transaction","detail":"{read_only:false; response_revision:9313; number_of_response:1; }","duration":"2.102225832s","start":"2026-05-26T20:37:36.958739Z","end":"2026-05-26T20:37:39.060964Z","steps":["trace[1723986828] 'process raft request' (duration: 2.101926581s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:37:39.061112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:37:36.958715Z","time spent":"2.102325046s","remote":"127.0.0.1:55048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T20:37:39.060883Z","caller":"traceutil/trace.go:171","msg":"trace[635160838] transaction","detail":"{read_only:false; response_revision:9314; number_of_response:1; }","duration":"1.944547903s","start":"2026-05-26T20:37:37.116311Z","end":"2026-05-26T20:37:39.060859Z","steps":["trace[635160838] 'process raft request' (duration: 1.944426129s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:37:39.061307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.655317251s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T20:37:39.061012Z","caller":"traceutil/trace.go:171","msg":"trace[2025694040] linearizableReadLoop","detail":"{readStateIndex:9655; appliedIndex:9648; }","duration":"3.655146114s","start":"2026-05-26T20:37:35.405839Z","end":"2026-05-26T20:37:39.060985Z","steps":["trace[2025694040] 'read index received' (duration: 3.26101536s)","trace[2025694040] 'applied index is now lower than readState.Index' (duration: 394.126564ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T20:37:39.061391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:37:37.116289Z","time spent":"1.945047672s","remote":"127.0.0.1:55048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T20:37:39.061417Z","caller":"traceutil/trace.go:171","msg":"trace[1657167857] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:9315; }","duration":"3.6555747s","start":"2026-05-26T20:37:35.405822Z","end":"2026-05-26T20:37:39.061397Z","steps":["trace[1657167857] 'agreement among raft nodes before linearized reading' (duration: 3.655280529s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:37:39.061532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.176213512s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-05-26T20:37:39.061553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.605440502s","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-26T20:37:39.061572Z","caller":"traceutil/trace.go:171","msg":"trace[819966985] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9315; }","duration":"3.176294075s","start":"2026-05-26T20:37:35.885267Z","end":"2026-05-26T20:37:39.061561Z","steps":["trace[819966985] 'agreement among raft nodes before linearized reading' (duration: 3.176199441s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:37:39.061577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:37:35.405802Z","time spent":"3.655700024s","remote":"127.0.0.1:41874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"warn","ts":"2026-05-26T20:37:39.061664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.556903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T20:37:39.061686Z","caller":"traceutil/trace.go:171","msg":"trace[2089206805] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9315; }","duration":"262.604615ms","start":"2026-05-26T20:37:38.799076Z","end":"2026-05-26T20:37:39.061681Z","steps":["trace[2089206805] 'agreement among raft nodes before linearized reading' (duration: 262.576174ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:37:39.061681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.729744218s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-05-26T20:37:39.061699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.622044193s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-05-26T20:37:39.061724Z","caller":"traceutil/trace.go:171","msg":"trace[2092901857] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9315; }","duration":"2.729818651s","start":"2026-05-26T20:37:36.331893Z","end":"2026-05-26T20:37:39.061712Z","steps":["trace[2092901857] 'agreement among raft nodes before linearized reading' (duration: 2.729680366s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:37:39.061764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:37:36.331877Z","time spent":"2.729880033s","remote":"127.0.0.1:55048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-26T20:37:39.061823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"883.847263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T20:37:39.061906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.393795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-26T20:37:39.061906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.397872465s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T20:37:39.061936Z","caller":"traceutil/trace.go:171","msg":"trace[1988166602] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:9315; }","duration":"110.423476ms","start":"2026-05-26T20:37:38.951505Z","end":"2026-05-26T20:37:39.061928Z","steps":["trace[1988166602] 'agreement among raft nodes before linearized reading' (duration: 110.379924ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:37:39.061941Z","caller":"traceutil/trace.go:171","msg":"trace[448837086] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:9315; }","duration":"2.397945767s","start":"2026-05-26T20:37:36.663988Z","end":"2026-05-26T20:37:39.061934Z","steps":["trace[448837086] 'agreement among raft nodes before linearized reading' (duration: 2.397890665s)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:37:39.061588Z","caller":"traceutil/trace.go:171","msg":"trace[616546425] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9315; }","duration":"2.605504045s","start":"2026-05-26T20:37:36.456073Z","end":"2026-05-26T20:37:39.061577Z","steps":["trace[616546425] 'agreement among raft nodes before linearized reading' (duration: 2.605437063s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:37:39.06197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:37:36.663968Z","time spent":"2.397995519s","remote":"127.0.0.1:55248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":6,"response size":30,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"info","ts":"2026-05-26T20:37:39.061978Z","caller":"traceutil/trace.go:171","msg":"trace[1396361539] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9315; }","duration":"884.06155ms","start":"2026-05-26T20:37:38.177845Z","end":"2026-05-26T20:37:39.061906Z","steps":["trace[1396361539] 'agreement among raft nodes before linearized reading' (duration: 883.638975ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:37:39.061726Z","caller":"traceutil/trace.go:171","msg":"trace[988058111] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9315; }","duration":"1.622106215s","start":"2026-05-26T20:37:37.439612Z","end":"2026-05-26T20:37:39.061718Z","steps":["trace[988058111] 'agreement among raft nodes before linearized reading' (duration: 1.621997891s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:37:39.062056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:37:36.456056Z","time spent":"2.60594497s","remote":"127.0.0.1:55048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-26T20:37:39.062131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:37:37.439593Z","time spent":"1.622530691s","remote":"127.0.0.1:54990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-05-26T20:37:39.062111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:37:38.177829Z","time spent":"884.264998ms","remote":"127.0.0.1:54786","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-26T20:37:39.062247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.894081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T20:37:39.062277Z","caller":"traceutil/trace.go:171","msg":"trace[722054744] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:9315; }","duration":"544.963854ms","start":"2026-05-26T20:37:38.517307Z","end":"2026-05-26T20:37:39.062271Z","steps":["trace[722054744] 'agreement among raft nodes before linearized reading' (duration: 544.921233ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:37:39.062297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:37:38.517286Z","time spent":"545.005315ms","remote":"127.0.0.1:47866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"warn","ts":"2026-05-26T20:37:39.062297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"798.311031ms","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:5"} {"level":"warn","ts":"2026-05-26T20:37:39.061595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:37:35.885247Z","time spent":"3.176343827s","remote":"127.0.0.1:55048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-26T20:37:39.062365Z","caller":"traceutil/trace.go:171","msg":"trace[108846499] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:9315; }","duration":"798.382384ms","start":"2026-05-26T20:37:38.263964Z","end":"2026-05-26T20:37:39.062347Z","steps":["trace[108846499] 'agreement among raft nodes before linearized reading' (duration: 798.27723ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:37:39.062396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.237821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T20:37:39.062414Z","caller":"traceutil/trace.go:171","msg":"trace[603468536] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:9315; }","duration":"460.298524ms","start":"2026-05-26T20:37:38.60211Z","end":"2026-05-26T20:37:39.062408Z","steps":["trace[603468536] 'agreement among raft nodes before linearized reading' (duration: 460.269403ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:37:39.062431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:37:38.602088Z","time spent":"460.339055ms","remote":"127.0.0.1:54956","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"warn","ts":"2026-05-26T20:37:39.062421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:37:38.263946Z","time spent":"798.459116ms","remote":"127.0.0.1:41924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-05-26T20:37:39.061633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.731221472s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-05-26T20:37:39.061861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.362216605s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:500 ","response":"range_response_count:12 size:4389"} {"level":"info","ts":"2026-05-26T20:37:39.062631Z","caller":"traceutil/trace.go:171","msg":"trace[769389830] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9315; }","duration":"2.732232498s","start":"2026-05-26T20:37:36.330379Z","end":"2026-05-26T20:37:39.062611Z","steps":["trace[769389830] 'agreement among raft nodes before linearized reading' (duration: 2.731233572s)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:37:39.062646Z","caller":"traceutil/trace.go:171","msg":"trace[1924127301] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:12; response_revision:9315; }","duration":"2.363027614s","start":"2026-05-26T20:37:36.699599Z","end":"2026-05-26T20:37:39.062626Z","steps":["trace[1924127301] 'agreement among raft nodes before linearized reading' (duration: 2.362145572s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:37:39.062708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:37:36.699583Z","time spent":"2.363103217s","remote":"127.0.0.1:54912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":12,"response size":4412,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:500 "} {"level":"warn","ts":"2026-05-26T20:37:39.06273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:37:36.330363Z","time spent":"2.73230873s","remote":"127.0.0.1:55048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-26T20:37:39.06196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.724048012s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-26T20:37:39.06084Z","caller":"traceutil/trace.go:171","msg":"trace[812775628] transaction","detail":"{read_only:false; response_revision:9315; number_of_response:1; }","duration":"219.319605ms","start":"2026-05-26T20:37:38.841497Z","end":"2026-05-26T20:37:39.060817Z","steps":["trace[812775628] 'process raft request' (duration: 219.283214ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:37:39.062836Z","caller":"traceutil/trace.go:171","msg":"trace[1313087954] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9315; }","duration":"2.724947105s","start":"2026-05-26T20:37:36.337877Z","end":"2026-05-26T20:37:39.062824Z","steps":["trace[1313087954] 'agreement among raft nodes before linearized reading' (duration: 2.724035071s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:37:39.062995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T20:37:36.337867Z","time spent":"2.725111931s","remote":"127.0.0.1:55048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-26T20:37:39.203858Z","caller":"traceutil/trace.go:171","msg":"trace[148644863] transaction","detail":"{read_only:false; response_revision:9316; number_of_response:1; }","duration":"136.237476ms","start":"2026-05-26T20:37:39.067586Z","end":"2026-05-26T20:37:39.203824Z","steps":["trace[148644863] 'process raft request' (duration: 49.437555ms)","trace[148644863] 'compare' (duration: 86.665696ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T20:37:39.233185Z","caller":"traceutil/trace.go:171","msg":"trace[375425217] transaction","detail":"{read_only:false; response_revision:9317; number_of_response:1; }","duration":"165.333722ms","start":"2026-05-26T20:37:39.067814Z","end":"2026-05-26T20:37:39.233148Z","steps":["trace[375425217] 'process raft request' (duration: 165.190447ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:37:39.233472Z","caller":"traceutil/trace.go:171","msg":"trace[950263832] linearizableReadLoop","detail":"{readStateIndex:9659; appliedIndex:9656; }","duration":"165.343222ms","start":"2026-05-26T20:37:39.068117Z","end":"2026-05-26T20:37:39.23346Z","steps":["trace[950263832] 'read index received' (duration: 48.917516ms)","trace[950263832] 'applied index is now lower than readState.Index' (duration: 116.424566ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T20:37:39.233552Z","caller":"traceutil/trace.go:171","msg":"trace[457512192] transaction","detail":"{read_only:false; response_revision:9319; number_of_response:1; }","duration":"163.92882ms","start":"2026-05-26T20:37:39.069614Z","end":"2026-05-26T20:37:39.233543Z","steps":["trace[457512192] 'process raft request' (duration: 163.788685ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:37:39.233529Z","caller":"traceutil/trace.go:171","msg":"trace[1837694936] transaction","detail":"{read_only:false; response_revision:9318; number_of_response:1; }","duration":"163.94877ms","start":"2026-05-26T20:37:39.06955Z","end":"2026-05-26T20:37:39.233499Z","steps":["trace[1837694936] 'process raft request' (duration: 163.800555ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:37:39.233649Z","caller":"traceutil/trace.go:171","msg":"trace[2054390960] transaction","detail":"{read_only:false; response_revision:9320; number_of_response:1; }","duration":"162.655305ms","start":"2026-05-26T20:37:39.070986Z","end":"2026-05-26T20:37:39.233641Z","steps":["trace[2054390960] 'process raft request' (duration: 162.445087ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T20:37:39.233837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.705296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"warn","ts":"2026-05-26T20:37:39.233847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.726168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T20:37:39.234361Z","caller":"traceutil/trace.go:171","msg":"trace[539278729] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9320; }","duration":"165.788609ms","start":"2026-05-26T20:37:39.068075Z","end":"2026-05-26T20:37:39.233864Z","steps":["trace[539278729] 'agreement among raft nodes before linearized reading' (duration: 165.645323ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T20:37:39.234476Z","caller":"traceutil/trace.go:171","msg":"trace[366059485] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:9320; }","duration":"113.869934ms","start":"2026-05-26T20:37:39.120041Z","end":"2026-05-26T20:37:39.23391Z","steps":["trace[366059485] 'agreement among raft nodes before linearized reading' (duration: 113.697658ms)"],"step_count":1}