{"level":"warn","ts":"2026-04-18T22:08:05.935776Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-18T22:08:05.935861Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.246: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.246:2380","--initial-cluster=instance=https://199.204.45.246:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.246:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.246: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-04-18T22:08:05.935923Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-18T22:08:05.935943Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.246:2380"]} {"level":"info","ts":"2026-04-18T22:08:05.935984Z","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-04-18T22:08:05.936636Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.246:2379"]} {"level":"info","ts":"2026-04-18T22:08:05.936706Z","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.246:2380"],"listen-peer-urls":["https://199.204.45.246:2380"],"advertise-client-urls":["https://199.204.45.246:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.246:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.246: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-04-18T22:08:05.940328Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.420674ms"} {"level":"info","ts":"2026-04-18T22:08:05.94822Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ab97322ebdd79664","cluster-id":"87bc89380c3dc2c"} {"level":"info","ts":"2026-04-18T22:08:05.948273Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 switched to configuration voters=()"} {"level":"info","ts":"2026-04-18T22:08:05.948288Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became follower at term 0"} {"level":"info","ts":"2026-04-18T22:08:05.948298Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ab97322ebdd79664 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-18T22:08:05.948306Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became follower at term 1"} {"level":"info","ts":"2026-04-18T22:08:05.948336Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 switched to configuration voters=(12364406478303893092)"} {"level":"warn","ts":"2026-04-18T22:08:05.95343Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-18T22:08:05.954893Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-18T22:08:05.955888Z","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-04-18T22:08:05.957915Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ab97322ebdd79664","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-18T22:08:05.958051Z","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-04-18T22:08:05.958123Z","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-04-18T22:08:05.958132Z","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-04-18T22:08:05.958809Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ab97322ebdd79664","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-18T22:08:05.960309Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 switched to configuration voters=(12364406478303893092)"} {"level":"info","ts":"2026-04-18T22:08:05.960471Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87bc89380c3dc2c","local-member-id":"ab97322ebdd79664","added-peer-id":"ab97322ebdd79664","added-peer-peer-urls":["https://199.204.45.246:2380"]} {"level":"info","ts":"2026-04-18T22:08:05.963887Z","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-04-18T22:08:05.964048Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.246:2380"} {"level":"info","ts":"2026-04-18T22:08:05.96408Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.246:2380"} {"level":"info","ts":"2026-04-18T22:08:05.964287Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ab97322ebdd79664","initial-advertise-peer-urls":["https://199.204.45.246:2380"],"listen-peer-urls":["https://199.204.45.246:2380"],"advertise-client-urls":["https://199.204.45.246:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.246:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-18T22:08:05.964332Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-18T22:08:06.349259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 is starting a new election at term 1"} {"level":"info","ts":"2026-04-18T22:08:06.349317Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-18T22:08:06.349353Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 received MsgPreVoteResp from ab97322ebdd79664 at term 1"} {"level":"info","ts":"2026-04-18T22:08:06.349378Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became candidate at term 2"} {"level":"info","ts":"2026-04-18T22:08:06.349391Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 received MsgVoteResp from ab97322ebdd79664 at term 2"} {"level":"info","ts":"2026-04-18T22:08:06.349413Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became leader at term 2"} {"level":"info","ts":"2026-04-18T22:08:06.349432Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ab97322ebdd79664 elected leader ab97322ebdd79664 at term 2"} {"level":"info","ts":"2026-04-18T22:08:06.351819Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T22:08:06.352244Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-18T22:08:06.352299Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-18T22:08:06.352257Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ab97322ebdd79664","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.246:2379]}","request-path":"/0/members/ab97322ebdd79664/attributes","cluster-id":"87bc89380c3dc2c","publish-timeout":"7s"} {"level":"info","ts":"2026-04-18T22:08:06.352802Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-18T22:08:06.352885Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-18T22:08:06.35392Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87bc89380c3dc2c","local-member-id":"ab97322ebdd79664","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T22:08:06.354033Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T22:08:06.354093Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T22:08:06.35549Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.246:2379"} {"level":"info","ts":"2026-04-18T22:08:06.36018Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-18T22:08:12.531328Z","caller":"traceutil/trace.go:171","msg":"trace[1354635479] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"106.453531ms","start":"2026-04-18T22:08:12.42485Z","end":"2026-04-18T22:08:12.531304Z","steps":["trace[1354635479] 'process raft request' (duration: 105.960954ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:08:22.293468Z","caller":"traceutil/trace.go:171","msg":"trace[1742985826] linearizableReadLoop","detail":"{readStateIndex:460; appliedIndex:459; }","duration":"148.081649ms","start":"2026-04-18T22:08:22.145362Z","end":"2026-04-18T22:08:22.293443Z","steps":["trace[1742985826] 'read index received' (duration: 147.783725ms)","trace[1742985826] 'applied index is now lower than readState.Index' (duration: 296.984µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:08:22.293593Z","caller":"traceutil/trace.go:171","msg":"trace[971683391] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"168.729407ms","start":"2026-04-18T22:08:22.124825Z","end":"2026-04-18T22:08:22.293554Z","steps":["trace[971683391] 'process raft request' (duration: 168.302842ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:08:22.293669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.918881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6965"} {"level":"info","ts":"2026-04-18T22:08:22.293749Z","caller":"traceutil/trace.go:171","msg":"trace[1155393132] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:445; }","duration":"135.058952ms","start":"2026-04-18T22:08:22.158677Z","end":"2026-04-18T22:08:22.293736Z","steps":["trace[1155393132] 'agreement among raft nodes before linearized reading' (duration: 134.91061ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:08:22.293745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.339003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:08:22.293872Z","caller":"traceutil/trace.go:171","msg":"trace[498006949] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:445; }","duration":"148.538484ms","start":"2026-04-18T22:08:22.145306Z","end":"2026-04-18T22:08:22.293844Z","steps":["trace[498006949] 'agreement among raft nodes before linearized reading' (duration: 148.279781ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:08:22.593587Z","caller":"traceutil/trace.go:171","msg":"trace[100493810] transaction","detail":"{read_only:false; response_revision:446; number_of_response:1; }","duration":"290.763093ms","start":"2026-04-18T22:08:22.302806Z","end":"2026-04-18T22:08:22.593569Z","steps":["trace[100493810] 'process raft request' (duration: 290.441299ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:08:22.887933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.120169ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T22:08:22.88803Z","caller":"traceutil/trace.go:171","msg":"trace[1906768313] linearizableReadLoop","detail":"{readStateIndex:462; appliedIndex:461; }","duration":"290.098896ms","start":"2026-04-18T22:08:22.597918Z","end":"2026-04-18T22:08:22.888016Z","steps":["trace[1906768313] 'read index received' (duration: 87.374251ms)","trace[1906768313] 'applied index is now lower than readState.Index' (duration: 202.723455ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:08:22.888057Z","caller":"traceutil/trace.go:171","msg":"trace[297013721] transaction","detail":"{read_only:false; response_revision:447; number_of_response:1; }","duration":"291.388091ms","start":"2026-04-18T22:08:22.596649Z","end":"2026-04-18T22:08:22.888037Z","steps":["trace[297013721] 'process raft request' (duration: 88.646926ms)","trace[297013721] 'compare' (duration: 201.690663ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:08:22.888155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.234447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7303"} {"level":"info","ts":"2026-04-18T22:08:22.888188Z","caller":"traceutil/trace.go:171","msg":"trace[96125351] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:447; }","duration":"290.302148ms","start":"2026-04-18T22:08:22.597877Z","end":"2026-04-18T22:08:22.888179Z","steps":["trace[96125351] 'agreement among raft nodes before linearized reading' (duration: 290.219027ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:08:23.029928Z","caller":"traceutil/trace.go:171","msg":"trace[1099999303] transaction","detail":"{read_only:false; response_revision:448; number_of_response:1; }","duration":"134.623613ms","start":"2026-04-18T22:08:22.895288Z","end":"2026-04-18T22:08:23.029912Z","steps":["trace[1099999303] 'process raft request' (duration: 130.411292ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:08:28.427304Z","caller":"traceutil/trace.go:171","msg":"trace[1267603125] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"104.290057ms","start":"2026-04-18T22:08:28.322988Z","end":"2026-04-18T22:08:28.427278Z","steps":["trace[1267603125] 'process raft request' (duration: 104.068234ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:08:34.212573Z","caller":"traceutil/trace.go:171","msg":"trace[1817248455] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"154.82346ms","start":"2026-04-18T22:08:34.057724Z","end":"2026-04-18T22:08:34.212548Z","steps":["trace[1817248455] 'process raft request' (duration: 154.78018ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:08:34.21286Z","caller":"traceutil/trace.go:171","msg":"trace[1111495934] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"155.118243ms","start":"2026-04-18T22:08:34.05772Z","end":"2026-04-18T22:08:34.212838Z","steps":["trace[1111495934] 'process raft request' (duration: 67.641149ms)","trace[1111495934] 'compare' (duration: 86.961998ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:08:34.444159Z","caller":"traceutil/trace.go:171","msg":"trace[1067645731] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"134.397879ms","start":"2026-04-18T22:08:34.309747Z","end":"2026-04-18T22:08:34.444145Z","steps":["trace[1067645731] 'process raft request' (duration: 61.863429ms)","trace[1067645731] 'compare' (duration: 72.394778ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:08:36.364253Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10836959925205549149,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-18T22:08:36.578786Z","caller":"traceutil/trace.go:171","msg":"trace[1286945067] linearizableReadLoop","detail":"{readStateIndex:529; appliedIndex:528; }","duration":"714.782098ms","start":"2026-04-18T22:08:35.863985Z","end":"2026-04-18T22:08:36.578767Z","steps":["trace[1286945067] 'read index received' (duration: 714.617797ms)","trace[1286945067] 'applied index is now lower than readState.Index' (duration: 163.661µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:08:36.578878Z","caller":"traceutil/trace.go:171","msg":"trace[1087335769] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"755.278771ms","start":"2026-04-18T22:08:35.823587Z","end":"2026-04-18T22:08:36.578866Z","steps":["trace[1087335769] 'process raft request' (duration: 755.078249ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:08:36.579052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"687.662001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-18T22:08:36.579053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.731709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-18T22:08:36.579062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"715.036991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:08:36.579089Z","caller":"traceutil/trace.go:171","msg":"trace[965122238] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:511; }","duration":"687.728761ms","start":"2026-04-18T22:08:35.891348Z","end":"2026-04-18T22:08:36.579077Z","steps":["trace[965122238] 'agreement among raft nodes before linearized reading' (duration: 687.65022ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:08:36.579101Z","caller":"traceutil/trace.go:171","msg":"trace[1196445364] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:511; }","duration":"106.815969ms","start":"2026-04-18T22:08:36.472271Z","end":"2026-04-18T22:08:36.579087Z","steps":["trace[1196445364] 'agreement among raft nodes before linearized reading' (duration: 106.731698ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:08:36.579141Z","caller":"traceutil/trace.go:171","msg":"trace[2029345903] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:511; }","duration":"715.155841ms","start":"2026-04-18T22:08:35.863955Z","end":"2026-04-18T22:08:36.579111Z","steps":["trace[2029345903] 'agreement among raft nodes before linearized reading' (duration: 715.00158ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:08:36.579134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:08:35.891335Z","time spent":"687.791042ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-18T22:08:36.579199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:08:35.863941Z","time spent":"715.248012ms","remote":"127.0.0.1:60684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"warn","ts":"2026-04-18T22:08:36.579446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:08:35.823577Z","time spent":"755.683165ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:08:36.698633Z","caller":"traceutil/trace.go:171","msg":"trace[2134818919] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"115.660369ms","start":"2026-04-18T22:08:36.582933Z","end":"2026-04-18T22:08:36.698593Z","steps":["trace[2134818919] 'process raft request' (duration: 110.969261ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:08:36.698811Z","caller":"traceutil/trace.go:171","msg":"trace[1379237063] linearizableReadLoop","detail":"{readStateIndex:531; appliedIndex:529; }","duration":"106.267504ms","start":"2026-04-18T22:08:36.592534Z","end":"2026-04-18T22:08:36.698801Z","steps":["trace[1379237063] 'read index received' (duration: 101.399785ms)","trace[1379237063] 'applied index is now lower than readState.Index' (duration: 4.866879ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:08:36.698904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.356875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:08:36.698941Z","caller":"traceutil/trace.go:171","msg":"trace[2122159704] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:513; }","duration":"106.430295ms","start":"2026-04-18T22:08:36.5925Z","end":"2026-04-18T22:08:36.698931Z","steps":["trace[2122159704] 'agreement among raft nodes before linearized reading' (duration: 106.340895ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:08:36.698947Z","caller":"traceutil/trace.go:171","msg":"trace[1779402939] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"115.369296ms","start":"2026-04-18T22:08:36.583558Z","end":"2026-04-18T22:08:36.698927Z","steps":["trace[1779402939] 'process raft request' (duration: 114.997323ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:08:39.270468Z","caller":"traceutil/trace.go:171","msg":"trace[1307617660] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"290.309255ms","start":"2026-04-18T22:08:38.98014Z","end":"2026-04-18T22:08:39.270449Z","steps":["trace[1307617660] 'process raft request' (duration: 290.198294ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:08:42.972188Z","caller":"traceutil/trace.go:171","msg":"trace[1054354570] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"150.582672ms","start":"2026-04-18T22:08:42.821584Z","end":"2026-04-18T22:08:42.972167Z","steps":["trace[1054354570] 'process raft request' (duration: 150.127068ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:08:43.471657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.199399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-zqrdj\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-18T22:08:43.471749Z","caller":"traceutil/trace.go:171","msg":"trace[921432099] range","detail":"{range_begin:/registry/pods/kube-system/cilium-zqrdj; range_end:; response_count:1; response_revision:622; }","duration":"213.344551ms","start":"2026-04-18T22:08:43.258384Z","end":"2026-04-18T22:08:43.471728Z","steps":["trace[921432099] 'range keys from in-memory index tree' (duration: 213.106919ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:08:43.471774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.232232ms","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-04-18T22:08:43.471835Z","caller":"traceutil/trace.go:171","msg":"trace[1250999597] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:622; }","duration":"191.301773ms","start":"2026-04-18T22:08:43.280518Z","end":"2026-04-18T22:08:43.471819Z","steps":["trace[1250999597] 'range keys from in-memory index tree' (duration: 191.120431ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:08:44.324681Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10836959925205549340,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-18T22:08:44.455149Z","caller":"traceutil/trace.go:171","msg":"trace[873955767] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"978.635385ms","start":"2026-04-18T22:08:43.476489Z","end":"2026-04-18T22:08:44.455124Z","steps":["trace[873955767] 'process raft request' (duration: 978.458354ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:08:44.455417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:08:43.476474Z","time spent":"978.751136ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:08:44.510029Z","caller":"traceutil/trace.go:171","msg":"trace[231808474] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"1.029967874s","start":"2026-04-18T22:08:43.480033Z","end":"2026-04-18T22:08:44.510001Z","steps":["trace[231808474] 'process raft request' (duration: 1.028104287s)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:08:44.510164Z","caller":"traceutil/trace.go:171","msg":"trace[1566450823] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"1.022318432s","start":"2026-04-18T22:08:43.487832Z","end":"2026-04-18T22:08:44.510151Z","steps":["trace[1566450823] 'process raft request' (duration: 1.022055859s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:08:44.510226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:08:43.487823Z","time spent":"1.022362693s","remote":"127.0.0.1:60770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:08:44.510793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:08:43.479989Z","time spent":"1.030111155s","remote":"127.0.0.1:60684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:08:44.527091Z","caller":"traceutil/trace.go:171","msg":"trace[1677575148] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:644; }","duration":"703.380435ms","start":"2026-04-18T22:08:43.823669Z","end":"2026-04-18T22:08:44.527049Z","steps":["trace[1677575148] 'read index received' (duration: 631.395863ms)","trace[1677575148] 'applied index is now lower than readState.Index' (duration: 71.983512ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:08:44.527159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"703.497976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:08:44.527181Z","caller":"traceutil/trace.go:171","msg":"trace[113721969] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:625; }","duration":"703.577318ms","start":"2026-04-18T22:08:43.823596Z","end":"2026-04-18T22:08:44.527173Z","steps":["trace[113721969] 'agreement among raft nodes before linearized reading' (duration: 703.529957ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:08:44.527207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:08:43.823571Z","time spent":"703.631858ms","remote":"127.0.0.1:60602","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-04-18T22:08:52.61122Z","caller":"traceutil/trace.go:171","msg":"trace[70513955] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"126.878169ms","start":"2026-04-18T22:08:52.484299Z","end":"2026-04-18T22:08:52.611177Z","steps":["trace[70513955] 'process raft request' (duration: 91.367329ms)","trace[70513955] 'compare' (duration: 35.130877ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:08:52.611211Z","caller":"traceutil/trace.go:171","msg":"trace[296896499] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"124.775551ms","start":"2026-04-18T22:08:52.486397Z","end":"2026-04-18T22:08:52.611172Z","steps":["trace[296896499] 'process raft request' (duration: 124.6528ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:09:00.628748Z","caller":"traceutil/trace.go:171","msg":"trace[1090291272] transaction","detail":"{read_only:false; response_revision:788; number_of_response:1; }","duration":"270.265569ms","start":"2026-04-18T22:09:00.358459Z","end":"2026-04-18T22:09:00.628725Z","steps":["trace[1090291272] 'process raft request' (duration: 270.118808ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:09:02.189921Z","caller":"traceutil/trace.go:171","msg":"trace[1625888688] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"193.814057ms","start":"2026-04-18T22:09:01.996081Z","end":"2026-04-18T22:09:02.189895Z","steps":["trace[1625888688] 'process raft request' (duration: 193.681086ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:09:27.296289Z","caller":"traceutil/trace.go:171","msg":"trace[83739490] transaction","detail":"{read_only:false; response_revision:1171; number_of_response:1; }","duration":"107.256939ms","start":"2026-04-18T22:09:27.189Z","end":"2026-04-18T22:09:27.296257Z","steps":["trace[83739490] 'process raft request' (duration: 17.876495ms)","trace[83739490] 'compare' (duration: 89.241879ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:09:29.539285Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10836959925205550439,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-18T22:09:29.694561Z","caller":"traceutil/trace.go:171","msg":"trace[250398368] linearizableReadLoop","detail":"{readStateIndex:1213; appliedIndex:1212; }","duration":"655.687861ms","start":"2026-04-18T22:09:29.038847Z","end":"2026-04-18T22:09:29.694535Z","steps":["trace[250398368] 'read index received' (duration: 655.498725ms)","trace[250398368] 'applied index is now lower than readState.Index' (duration: 187.816µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:09:29.694763Z","caller":"traceutil/trace.go:171","msg":"trace[1406718509] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"818.731815ms","start":"2026-04-18T22:09:28.875966Z","end":"2026-04-18T22:09:29.694698Z","steps":["trace[1406718509] 'process raft request' (duration: 818.391825ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:09:29.695024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:09:28.875948Z","time spent":"818.937261ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:09:29.695199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"656.247368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-18T22:09:29.695268Z","caller":"traceutil/trace.go:171","msg":"trace[506933318] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1179; }","duration":"656.448503ms","start":"2026-04-18T22:09:29.038806Z","end":"2026-04-18T22:09:29.695255Z","steps":["trace[506933318] 'agreement among raft nodes before linearized reading' (duration: 655.938648ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:09:29.695316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:09:29.038795Z","time spent":"656.510725ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-18T22:09:29.875944Z","caller":"traceutil/trace.go:171","msg":"trace[182208332] transaction","detail":"{read_only:false; response_revision:1180; number_of_response:1; }","duration":"187.711438ms","start":"2026-04-18T22:09:29.688198Z","end":"2026-04-18T22:09:29.875909Z","steps":["trace[182208332] 'process raft request' (duration: 186.862752ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:09:29.875908Z","caller":"traceutil/trace.go:171","msg":"trace[131984519] linearizableReadLoop","detail":"{readStateIndex:1214; appliedIndex:1213; }","duration":"181.157235ms","start":"2026-04-18T22:09:29.694709Z","end":"2026-04-18T22:09:29.875866Z","steps":["trace[131984519] 'read index received' (duration: 180.365182ms)","trace[131984519] 'applied index is now lower than readState.Index' (duration: 790.083µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:09:29.876152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.857376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.246\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-18T22:09:29.876234Z","caller":"traceutil/trace.go:171","msg":"trace[540768577] range","detail":"{range_begin:/registry/masterleases/199.204.45.246; range_end:; response_count:1; response_revision:1180; }","duration":"574.00611ms","start":"2026-04-18T22:09:29.30221Z","end":"2026-04-18T22:09:29.876216Z","steps":["trace[540768577] 'agreement among raft nodes before linearized reading' (duration: 573.710471ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:09:29.876357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:09:29.30219Z","time spent":"574.154224ms","remote":"127.0.0.1:60632","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.246\" "} {"level":"warn","ts":"2026-04-18T22:09:29.876411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.365355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-18T22:09:29.876487Z","caller":"traceutil/trace.go:171","msg":"trace[1135782853] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1180; }","duration":"721.475068ms","start":"2026-04-18T22:09:29.154994Z","end":"2026-04-18T22:09:29.876469Z","steps":["trace[1135782853] 'agreement among raft nodes before linearized reading' (duration: 721.283862ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:09:29.876533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:09:29.154984Z","time spent":"721.54046ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-18T22:09:29.876651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.774941ms","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-04-18T22:09:29.876755Z","caller":"traceutil/trace.go:171","msg":"trace[2022323360] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1180; }","duration":"575.924296ms","start":"2026-04-18T22:09:29.300816Z","end":"2026-04-18T22:09:29.87674Z","steps":["trace[2022323360] 'agreement among raft nodes before linearized reading' (duration: 575.173134ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:09:29.87682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:09:29.300796Z","time spent":"576.011849ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-18T22:09:29.879498Z","caller":"traceutil/trace.go:171","msg":"trace[1262392986] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"179.479726ms","start":"2026-04-18T22:09:29.699998Z","end":"2026-04-18T22:09:29.879478Z","steps":["trace[1262392986] 'process raft request' (duration: 179.207678ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:09:29.879637Z","caller":"traceutil/trace.go:171","msg":"trace[1853576767] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"111.620279ms","start":"2026-04-18T22:09:29.768003Z","end":"2026-04-18T22:09:29.879623Z","steps":["trace[1853576767] 'process raft request' (duration: 111.361031ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:09:45.64681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.074855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-admission-create-24m6j\" ","response":"range_response_count:1 size:4197"} {"level":"info","ts":"2026-04-18T22:09:45.646893Z","caller":"traceutil/trace.go:171","msg":"trace[2062924508] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-admission-create-24m6j; range_end:; response_count:1; response_revision:1318; }","duration":"107.170397ms","start":"2026-04-18T22:09:45.539705Z","end":"2026-04-18T22:09:45.646875Z","steps":["trace[2062924508] 'range keys from in-memory index tree' (duration: 106.902721ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:09:54.247112Z","caller":"traceutil/trace.go:171","msg":"trace[2117876348] transaction","detail":"{read_only:false; response_revision:1451; number_of_response:1; }","duration":"224.770378ms","start":"2026-04-18T22:09:54.022315Z","end":"2026-04-18T22:09:54.247086Z","steps":["trace[2117876348] 'process raft request' (duration: 221.850121ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:09:54.248936Z","caller":"traceutil/trace.go:171","msg":"trace[295655594] linearizableReadLoop","detail":"{readStateIndex:1496; appliedIndex:1494; }","duration":"219.394414ms","start":"2026-04-18T22:09:54.02952Z","end":"2026-04-18T22:09:54.248915Z","steps":["trace[295655594] 'read index received' (duration: 215.139838ms)","trace[295655594] 'applied index is now lower than readState.Index' (duration: 4.253686ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:09:54.248971Z","caller":"traceutil/trace.go:171","msg":"trace[116274729] transaction","detail":"{read_only:false; response_revision:1452; number_of_response:1; }","duration":"223.259043ms","start":"2026-04-18T22:09:54.025693Z","end":"2026-04-18T22:09:54.248952Z","steps":["trace[116274729] 'process raft request' (duration: 223.11621ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:09:54.249119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.588129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-18T22:09:54.249159Z","caller":"traceutil/trace.go:171","msg":"trace[1264115501] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1452; }","duration":"219.677331ms","start":"2026-04-18T22:09:54.02947Z","end":"2026-04-18T22:09:54.249147Z","steps":["trace[1264115501] 'agreement among raft nodes before linearized reading' (duration: 219.532107ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:10:17.038196Z","caller":"traceutil/trace.go:171","msg":"trace[1455093855] linearizableReadLoop","detail":"{readStateIndex:1926; appliedIndex:1925; }","duration":"418.05424ms","start":"2026-04-18T22:10:16.620087Z","end":"2026-04-18T22:10:17.038141Z","steps":["trace[1455093855] 'read index received' (duration: 417.845726ms)","trace[1455093855] 'applied index is now lower than readState.Index' (duration: 207.404µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:10:17.038277Z","caller":"traceutil/trace.go:171","msg":"trace[34900647] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"477.867174ms","start":"2026-04-18T22:10:16.56039Z","end":"2026-04-18T22:10:17.038257Z","steps":["trace[34900647] 'process raft request' (duration: 477.605559ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:17.038453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.897787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:10:17.038502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.810481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1c8c132c-ea8a-43f9-ab94-0c4cb0ab8687\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-18T22:10:17.038673Z","caller":"traceutil/trace.go:171","msg":"trace[1098853379] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1c8c132c-ea8a-43f9-ab94-0c4cb0ab8687; range_end:; response_count:1; response_revision:1855; }","duration":"345.009324ms","start":"2026-04-18T22:10:16.693648Z","end":"2026-04-18T22:10:17.038657Z","steps":["trace[1098853379] 'agreement among raft nodes before linearized reading' (duration: 344.673468ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:17.038716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.440515ms","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-04-18T22:10:17.038516Z","caller":"traceutil/trace.go:171","msg":"trace[333200682] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1855; }","duration":"214.997479ms","start":"2026-04-18T22:10:16.8235Z","end":"2026-04-18T22:10:17.038498Z","steps":["trace[333200682] 'agreement among raft nodes before linearized reading' (duration: 214.924638ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:10:17.038791Z","caller":"traceutil/trace.go:171","msg":"trace[1839122878] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1855; }","duration":"314.549077ms","start":"2026-04-18T22:10:16.724223Z","end":"2026-04-18T22:10:17.038772Z","steps":["trace[1839122878] 'agreement among raft nodes before linearized reading' (duration: 314.322253ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:17.038372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.269203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:10:17.03886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:10:16.724205Z","time spent":"314.620868ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-18T22:10:17.038782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:10:16.693637Z","time spent":"345.131737ms","remote":"127.0.0.1:60770","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-1c8c132c-ea8a-43f9-ab94-0c4cb0ab8687\" "} {"level":"info","ts":"2026-04-18T22:10:17.038899Z","caller":"traceutil/trace.go:171","msg":"trace[237030501] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1855; }","duration":"418.901105ms","start":"2026-04-18T22:10:16.619982Z","end":"2026-04-18T22:10:17.038883Z","steps":["trace[237030501] 'agreement among raft nodes before linearized reading' (duration: 418.292954ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:17.038953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:10:16.619967Z","time spent":"418.972446ms","remote":"127.0.0.1:46902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-04-18T22:10:17.038463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:10:16.560349Z","time spent":"477.976115ms","remote":"127.0.0.1:60868","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-04-18T22:10:25.92438Z","caller":"traceutil/trace.go:171","msg":"trace[1965203907] linearizableReadLoop","detail":"{readStateIndex:2012; appliedIndex:2011; }","duration":"100.074152ms","start":"2026-04-18T22:10:25.824287Z","end":"2026-04-18T22:10:25.924361Z","steps":["trace[1965203907] 'read index received' (duration: 99.903149ms)","trace[1965203907] 'applied index is now lower than readState.Index' (duration: 170.173µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:10:25.924419Z","caller":"traceutil/trace.go:171","msg":"trace[1090839462] transaction","detail":"{read_only:false; response_revision:1939; number_of_response:1; }","duration":"100.446339ms","start":"2026-04-18T22:10:25.823945Z","end":"2026-04-18T22:10:25.924392Z","steps":["trace[1090839462] 'process raft request' (duration: 100.243826ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:25.924503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.194554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:10:25.924534Z","caller":"traceutil/trace.go:171","msg":"trace[1327678624] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1939; }","duration":"100.258825ms","start":"2026-04-18T22:10:25.824266Z","end":"2026-04-18T22:10:25.924525Z","steps":["trace[1327678624] 'agreement among raft nodes before linearized reading' (duration: 100.192304ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:10:34.107996Z","caller":"traceutil/trace.go:171","msg":"trace[1834716359] transaction","detail":"{read_only:false; response_revision:1988; number_of_response:1; }","duration":"855.946001ms","start":"2026-04-18T22:10:33.252024Z","end":"2026-04-18T22:10:34.10797Z","steps":["trace[1834716359] 'process raft request' (duration: 855.701236ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:10:34.108093Z","caller":"traceutil/trace.go:171","msg":"trace[1206848931] linearizableReadLoop","detail":"{readStateIndex:2062; appliedIndex:2061; }","duration":"283.441715ms","start":"2026-04-18T22:10:33.824541Z","end":"2026-04-18T22:10:34.107983Z","steps":["trace[1206848931] 'read index received' (duration: 283.20758ms)","trace[1206848931] 'applied index is now lower than readState.Index' (duration: 231.465µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:10:34.108264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.706839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:10:34.108275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:10:33.252011Z","time spent":"856.061783ms","remote":"127.0.0.1:60770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5918,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:10:34.108303Z","caller":"traceutil/trace.go:171","msg":"trace[341699879] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1988; }","duration":"283.825751ms","start":"2026-04-18T22:10:33.824468Z","end":"2026-04-18T22:10:34.108294Z","steps":["trace[341699879] 'agreement among raft nodes before linearized reading' (duration: 283.73111ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:10:34.111401Z","caller":"traceutil/trace.go:171","msg":"trace[1932440836] transaction","detail":"{read_only:false; response_revision:1989; number_of_response:1; }","duration":"239.388686ms","start":"2026-04-18T22:10:33.87199Z","end":"2026-04-18T22:10:34.111378Z","steps":["trace[1932440836] 'process raft request' (duration: 238.97432ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:10:34.111624Z","caller":"traceutil/trace.go:171","msg":"trace[2125780683] transaction","detail":"{read_only:false; response_revision:1990; number_of_response:1; }","duration":"165.866815ms","start":"2026-04-18T22:10:33.945747Z","end":"2026-04-18T22:10:34.111613Z","steps":["trace[2125780683] 'process raft request' (duration: 165.342057ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:10:34.111755Z","caller":"traceutil/trace.go:171","msg":"trace[944601742] transaction","detail":"{read_only:false; response_revision:1991; number_of_response:1; }","duration":"115.827476ms","start":"2026-04-18T22:10:33.995917Z","end":"2026-04-18T22:10:34.111744Z","steps":["trace[944601742] 'process raft request' (duration: 115.224927ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:34.11197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.59452ms","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":"info","ts":"2026-04-18T22:10:34.112022Z","caller":"traceutil/trace.go:171","msg":"trace[1178043452] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1991; }","duration":"153.698192ms","start":"2026-04-18T22:10:33.958308Z","end":"2026-04-18T22:10:34.112006Z","steps":["trace[1178043452] 'agreement among raft nodes before linearized reading' (duration: 153.544709ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:47.109126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.362018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:10:47.109285Z","caller":"traceutil/trace.go:171","msg":"trace[643455854] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2079; }","duration":"285.578662ms","start":"2026-04-18T22:10:46.823685Z","end":"2026-04-18T22:10:47.109264Z","steps":["trace[643455854] 'range keys from in-memory index tree' (duration: 285.231857ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:47.10929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.725005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"info","ts":"2026-04-18T22:10:47.10938Z","caller":"traceutil/trace.go:171","msg":"trace[361445874] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2079; }","duration":"163.844736ms","start":"2026-04-18T22:10:46.945509Z","end":"2026-04-18T22:10:47.109354Z","steps":["trace[361445874] 'range keys from in-memory index tree' (duration: 163.485181ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:53.481254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.569637ms","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-04-18T22:10:53.481337Z","caller":"traceutil/trace.go:171","msg":"trace[1217293167] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2113; }","duration":"129.704169ms","start":"2026-04-18T22:10:53.351611Z","end":"2026-04-18T22:10:53.481315Z","steps":["trace[1217293167] 'range keys from in-memory index tree' (duration: 129.383515ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:10:54.31943Z","caller":"traceutil/trace.go:171","msg":"trace[365558417] transaction","detail":"{read_only:false; response_revision:2114; number_of_response:1; }","duration":"142.11167ms","start":"2026-04-18T22:10:54.177298Z","end":"2026-04-18T22:10:54.31941Z","steps":["trace[365558417] 'process raft request' (duration: 141.974028ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:10:54.64402Z","caller":"traceutil/trace.go:171","msg":"trace[1101584199] transaction","detail":"{read_only:false; response_revision:2115; number_of_response:1; }","duration":"464.334982ms","start":"2026-04-18T22:10:54.179665Z","end":"2026-04-18T22:10:54.644Z","steps":["trace[1101584199] 'process raft request' (duration: 464.17868ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:54.644152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:10:54.17965Z","time spent":"464.437223ms","remote":"127.0.0.1:60868","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-04-18T22:10:54.644422Z","caller":"traceutil/trace.go:171","msg":"trace[391200902] linearizableReadLoop","detail":"{readStateIndex:2194; appliedIndex:2191; }","duration":"340.373308ms","start":"2026-04-18T22:10:54.304032Z","end":"2026-04-18T22:10:54.644405Z","steps":["trace[391200902] 'read index received' (duration: 15.242263ms)","trace[391200902] 'applied index is now lower than readState.Index' (duration: 325.129775ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:10:54.644721Z","caller":"traceutil/trace.go:171","msg":"trace[895888568] transaction","detail":"{read_only:false; response_revision:2116; number_of_response:1; }","duration":"364.743758ms","start":"2026-04-18T22:10:54.279963Z","end":"2026-04-18T22:10:54.644706Z","steps":["trace[895888568] 'process raft request' (duration: 364.004887ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:54.644805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:10:54.27994Z","time spent":"364.823789ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:10:54.645018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.976328ms","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-04-18T22:10:54.645122Z","caller":"traceutil/trace.go:171","msg":"trace[485495825] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2116; }","duration":"341.10716ms","start":"2026-04-18T22:10:54.303989Z","end":"2026-04-18T22:10:54.645096Z","steps":["trace[485495825] 'agreement among raft nodes before linearized reading' (duration: 340.820196ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:54.645182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:10:54.303975Z","time spent":"341.191511ms","remote":"127.0.0.1:60868","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-04-18T22:10:54.707779Z","caller":"traceutil/trace.go:171","msg":"trace[163137541] transaction","detail":"{read_only:false; response_revision:2117; number_of_response:1; }","duration":"150.988912ms","start":"2026-04-18T22:10:54.556754Z","end":"2026-04-18T22:10:54.707743Z","steps":["trace[163137541] 'process raft request' (duration: 150.766849ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:54.707969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.55396ms","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-04-18T22:10:54.708085Z","caller":"traceutil/trace.go:171","msg":"trace[1167917797] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2117; }","duration":"219.689173ms","start":"2026-04-18T22:10:54.488356Z","end":"2026-04-18T22:10:54.708046Z","steps":["trace[1167917797] 'agreement among raft nodes before linearized reading' (duration: 219.475ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:10:54.83157Z","caller":"traceutil/trace.go:171","msg":"trace[1584307797] linearizableReadLoop","detail":"{readStateIndex:2196; appliedIndex:2195; }","duration":"123.909113ms","start":"2026-04-18T22:10:54.70764Z","end":"2026-04-18T22:10:54.83155Z","steps":["trace[1584307797] 'read index received' (duration: 28.58665ms)","trace[1584307797] 'applied index is now lower than readState.Index' (duration: 95.321483ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:10:54.831599Z","caller":"traceutil/trace.go:171","msg":"trace[1289084034] transaction","detail":"{read_only:false; response_revision:2118; number_of_response:1; }","duration":"182.919301ms","start":"2026-04-18T22:10:54.648658Z","end":"2026-04-18T22:10:54.831577Z","steps":["trace[1289084034] 'process raft request' (duration: 87.559518ms)","trace[1289084034] 'compare' (duration: 95.229962ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:10:54.831822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.811786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-18T22:10:54.831888Z","caller":"traceutil/trace.go:171","msg":"trace[1777105934] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2118; }","duration":"162.895677ms","start":"2026-04-18T22:10:54.668958Z","end":"2026-04-18T22:10:54.831854Z","steps":["trace[1777105934] 'agreement among raft nodes before linearized reading' (duration: 162.677144ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:10:54.908163Z","caller":"traceutil/trace.go:171","msg":"trace[351183566] transaction","detail":"{read_only:false; response_revision:2119; number_of_response:1; }","duration":"195.072861ms","start":"2026-04-18T22:10:54.713066Z","end":"2026-04-18T22:10:54.908139Z","steps":["trace[351183566] 'process raft request' (duration: 194.909248ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:10:54.908544Z","caller":"traceutil/trace.go:171","msg":"trace[525309214] transaction","detail":"{read_only:false; response_revision:2120; number_of_response:1; }","duration":"195.453476ms","start":"2026-04-18T22:10:54.71307Z","end":"2026-04-18T22:10:54.908524Z","steps":["trace[525309214] 'process raft request' (duration: 195.02862ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:10:54.909157Z","caller":"traceutil/trace.go:171","msg":"trace[676540521] transaction","detail":"{read_only:false; response_revision:2121; number_of_response:1; }","duration":"195.988154ms","start":"2026-04-18T22:10:54.713152Z","end":"2026-04-18T22:10:54.90914Z","steps":["trace[676540521] 'process raft request' (duration: 195.162342ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:55.913466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"969.258589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-18T22:10:55.914129Z","caller":"traceutil/trace.go:171","msg":"trace[922416118] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:2122; }","duration":"969.95536ms","start":"2026-04-18T22:10:54.944148Z","end":"2026-04-18T22:10:55.914104Z","steps":["trace[922416118] 'count revisions from in-memory index tree' (duration: 969.174257ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:55.914213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:10:54.944133Z","time spent":"970.051402ms","remote":"127.0.0.1:60684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":20,"response size":30,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"info","ts":"2026-04-18T22:10:55.915095Z","caller":"traceutil/trace.go:171","msg":"trace[1093486282] linearizableReadLoop","detail":"{readStateIndex:2202; appliedIndex:2201; }","duration":"487.383013ms","start":"2026-04-18T22:10:55.427683Z","end":"2026-04-18T22:10:55.915066Z","steps":["trace[1093486282] 'read index received' (duration: 476.97615ms)","trace[1093486282] 'applied index is now lower than readState.Index' (duration: 10.405283ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:10:55.915178Z","caller":"traceutil/trace.go:171","msg":"trace[1108229889] transaction","detail":"{read_only:false; response_revision:2123; number_of_response:1; }","duration":"674.108086ms","start":"2026-04-18T22:10:55.241022Z","end":"2026-04-18T22:10:55.91513Z","steps":["trace[1108229889] 'process raft request' (duration: 663.682753ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:55.91539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.696327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18a79308c556f518\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-04-18T22:10:55.915439Z","caller":"traceutil/trace.go:171","msg":"trace[1939145594] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18a79308c556f518; range_end:; response_count:1; response_revision:2123; }","duration":"487.795059ms","start":"2026-04-18T22:10:55.42763Z","end":"2026-04-18T22:10:55.915425Z","steps":["trace[1939145594] 'agreement among raft nodes before linearized reading' (duration: 487.619486ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:55.915461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:10:55.241006Z","time spent":"674.213107ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:10:55.915523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.916296ms","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-04-18T22:10:55.915584Z","caller":"traceutil/trace.go:171","msg":"trace[1907421721] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2123; }","duration":"200.016198ms","start":"2026-04-18T22:10:55.715556Z","end":"2026-04-18T22:10:55.915572Z","steps":["trace[1907421721] 'agreement among raft nodes before linearized reading' (duration: 199.774085ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:55.915471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:10:55.42761Z","time spent":"487.853839ms","remote":"127.0.0.1:60668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":869,"request content":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18a79308c556f518\" "} {"level":"warn","ts":"2026-04-18T22:10:57.237874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.128616447s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:10:57.237999Z","caller":"traceutil/trace.go:171","msg":"trace[609489228] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2123; }","duration":"1.128749399s","start":"2026-04-18T22:10:56.109228Z","end":"2026-04-18T22:10:57.237978Z","steps":["trace[609489228] 'range keys from in-memory index tree' (duration: 1.128601107s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:57.238311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"825.058029ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T22:10:57.238417Z","caller":"traceutil/trace.go:171","msg":"trace[1312777754] linearizableReadLoop","detail":"{readStateIndex:2203; appliedIndex:2202; }","duration":"1.122634729s","start":"2026-04-18T22:10:56.115766Z","end":"2026-04-18T22:10:57.2384Z","steps":["trace[1312777754] 'read index received' (duration: 297.376717ms)","trace[1312777754] 'applied index is now lower than readState.Index' (duration: 825.256932ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:10:57.238637Z","caller":"traceutil/trace.go:171","msg":"trace[380648551] transaction","detail":"{read_only:false; response_revision:2124; number_of_response:1; }","duration":"1.319532765s","start":"2026-04-18T22:10:55.919068Z","end":"2026-04-18T22:10:57.238601Z","steps":["trace[380648551] 'process raft request' (duration: 494.10212ms)","trace[380648551] 'compare' (duration: 824.016314ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:10:57.238706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:10:55.919052Z","time spent":"1.319620986s","remote":"127.0.0.1:60668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":831,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:10:57.238967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.123208298s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12383"} {"level":"info","ts":"2026-04-18T22:10:57.239003Z","caller":"traceutil/trace.go:171","msg":"trace[1314386114] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2124; }","duration":"1.123282819s","start":"2026-04-18T22:10:56.115711Z","end":"2026-04-18T22:10:57.238994Z","steps":["trace[1314386114] 'agreement among raft nodes before linearized reading' (duration: 1.123158508s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:57.239031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:10:56.115691Z","time spent":"1.12333314s","remote":"127.0.0.1:60770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12406,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-04-18T22:10:57.248127Z","caller":"traceutil/trace.go:171","msg":"trace[1655118887] transaction","detail":"{read_only:false; response_revision:2125; number_of_response:1; }","duration":"922.635008ms","start":"2026-04-18T22:10:56.325476Z","end":"2026-04-18T22:10:57.248111Z","steps":["trace[1655118887] 'process raft request' (duration: 922.533987ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:57.248247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:10:56.325448Z","time spent":"922.73394ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:10:57.285961Z","caller":"traceutil/trace.go:171","msg":"trace[109881142] transaction","detail":"{read_only:false; response_revision:2127; number_of_response:1; }","duration":"634.957108ms","start":"2026-04-18T22:10:56.650985Z","end":"2026-04-18T22:10:57.285942Z","steps":["trace[109881142] 'process raft request' (duration: 634.852297ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:10:57.285971Z","caller":"traceutil/trace.go:171","msg":"trace[1671177147] transaction","detail":"{read_only:false; response_revision:2126; number_of_response:1; }","duration":"654.179988ms","start":"2026-04-18T22:10:56.631773Z","end":"2026-04-18T22:10:57.285953Z","steps":["trace[1671177147] 'process raft request' (duration: 653.957115ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:57.286087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:10:56.631746Z","time spent":"654.28835ms","remote":"127.0.0.1:60868","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-04-18T22:10:57.286087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:10:56.650958Z","time spent":"635.05878ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:10:57.286299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.601035ms","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-04-18T22:10:57.286337Z","caller":"traceutil/trace.go:171","msg":"trace[148815911] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2128; }","duration":"362.682907ms","start":"2026-04-18T22:10:56.923643Z","end":"2026-04-18T22:10:57.286326Z","steps":["trace[148815911] 'agreement among raft nodes before linearized reading' (duration: 362.557175ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:10:57.286301Z","caller":"traceutil/trace.go:171","msg":"trace[590388473] transaction","detail":"{read_only:false; response_revision:2128; number_of_response:1; }","duration":"635.195333ms","start":"2026-04-18T22:10:56.65107Z","end":"2026-04-18T22:10:57.286265Z","steps":["trace[590388473] 'process raft request' (duration: 634.800476ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:57.286336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.766963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-18T22:10:57.286367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:10:56.923633Z","time spent":"362.727137ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-04-18T22:10:57.286401Z","caller":"traceutil/trace.go:171","msg":"trace[637057204] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2128; }","duration":"372.879435ms","start":"2026-04-18T22:10:56.913505Z","end":"2026-04-18T22:10:57.286385Z","steps":["trace[637057204] 'agreement among raft nodes before linearized reading' (duration: 372.673572ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:57.286449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:10:56.913486Z","time spent":"372.955296ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-18T22:10:57.286391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.804338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-18T22:10:57.286458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:10:56.651063Z","time spent":"635.319894ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:10:57.286551Z","caller":"traceutil/trace.go:171","msg":"trace[781749408] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2128; }","duration":"374.025191ms","start":"2026-04-18T22:10:56.91247Z","end":"2026-04-18T22:10:57.286495Z","steps":["trace[781749408] 'agreement among raft nodes before linearized reading' (duration: 373.717947ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:57.286666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.674391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-18T22:10:57.28676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.714963ms","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-04-18T22:10:57.286773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"946.881969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1986"} {"level":"info","ts":"2026-04-18T22:10:57.286803Z","caller":"traceutil/trace.go:171","msg":"trace[475617251] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2128; }","duration":"451.763133ms","start":"2026-04-18T22:10:56.835027Z","end":"2026-04-18T22:10:57.28679Z","steps":["trace[475617251] 'agreement among raft nodes before linearized reading' (duration: 451.682622ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:10:57.286763Z","caller":"traceutil/trace.go:171","msg":"trace[1274429493] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2128; }","duration":"372.869713ms","start":"2026-04-18T22:10:56.913878Z","end":"2026-04-18T22:10:57.286748Z","steps":["trace[1274429493] 'agreement among raft nodes before linearized reading' (duration: 372.386097ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:57.286672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.766972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-18T22:10:57.286862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.121448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:10:57.286842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:10:56.91245Z","time spent":"374.138503ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-18T22:10:57.286904Z","caller":"traceutil/trace.go:171","msg":"trace[1369400514] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2128; }","duration":"373.036137ms","start":"2026-04-18T22:10:56.913857Z","end":"2026-04-18T22:10:57.286893Z","steps":["trace[1369400514] 'agreement among raft nodes before linearized reading' (duration: 372.697712ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:10:57.286934Z","caller":"traceutil/trace.go:171","msg":"trace[404456087] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2128; }","duration":"463.20711ms","start":"2026-04-18T22:10:56.823691Z","end":"2026-04-18T22:10:57.286898Z","steps":["trace[404456087] 'agreement among raft nodes before linearized reading' (duration: 463.135579ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:57.286956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:10:56.913834Z","time spent":"373.112117ms","remote":"127.0.0.1:60868","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-04-18T22:10:57.286976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:10:56.823671Z","time spent":"463.297571ms","remote":"127.0.0.1:60602","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-04-18T22:10:57.28705Z","caller":"traceutil/trace.go:171","msg":"trace[2017393916] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:2128; }","duration":"946.962319ms","start":"2026-04-18T22:10:56.339838Z","end":"2026-04-18T22:10:57.286801Z","steps":["trace[2017393916] 'agreement among raft nodes before linearized reading' (duration: 946.765586ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:57.286834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:10:56.835019Z","time spent":"451.808144ms","remote":"127.0.0.1:60868","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-04-18T22:10:57.287066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:10:56.913868Z","time spent":"373.012275ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-18T22:10:57.287344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:10:56.339815Z","time spent":"947.517128ms","remote":"127.0.0.1:60782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":2009,"request content":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" "} {"level":"warn","ts":"2026-04-18T22:10:57.931589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.428079ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T22:10:57.932088Z","caller":"traceutil/trace.go:171","msg":"trace[1175835032] transaction","detail":"{read_only:false; response_revision:2129; number_of_response:1; }","duration":"639.483159ms","start":"2026-04-18T22:10:57.29258Z","end":"2026-04-18T22:10:57.932063Z","steps":["trace[1175835032] 'process raft request' (duration: 211.314409ms)","trace[1175835032] 'compare' (duration: 426.986463ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:10:57.932236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:10:57.292566Z","time spent":"639.58264ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:10:57.932317Z","caller":"traceutil/trace.go:171","msg":"trace[1346856217] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"639.687992ms","start":"2026-04-18T22:10:57.292602Z","end":"2026-04-18T22:10:57.93229Z","steps":["trace[1346856217] 'process raft request' (duration: 639.438788ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:10:57.932383Z","caller":"traceutil/trace.go:171","msg":"trace[1369804345] transaction","detail":"{read_only:false; response_revision:2133; number_of_response:1; }","duration":"638.431404ms","start":"2026-04-18T22:10:57.29394Z","end":"2026-04-18T22:10:57.932371Z","steps":["trace[1369804345] 'process raft request' (duration: 638.16184ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:57.932456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:10:57.29393Z","time spent":"638.475355ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:10:57.932462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:10:57.292577Z","time spent":"639.817243ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:10:57.932553Z","caller":"traceutil/trace.go:171","msg":"trace[236979955] linearizableReadLoop","detail":"{readStateIndex:2212; appliedIndex:2207; }","duration":"635.081885ms","start":"2026-04-18T22:10:57.297462Z","end":"2026-04-18T22:10:57.932544Z","steps":["trace[236979955] 'read index received' (duration: 206.413118ms)","trace[236979955] 'applied index is now lower than readState.Index' (duration: 428.667707ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:10:57.932602Z","caller":"traceutil/trace.go:171","msg":"trace[568680078] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"639.069263ms","start":"2026-04-18T22:10:57.293513Z","end":"2026-04-18T22:10:57.932583Z","steps":["trace[568680078] 'process raft request' (duration: 638.557416ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:57.932838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:10:57.293503Z","time spent":"639.316206ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:10:57.932924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.491744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:10:57.932953Z","caller":"traceutil/trace.go:171","msg":"trace[405708037] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:2134; }","duration":"399.555184ms","start":"2026-04-18T22:10:57.533391Z","end":"2026-04-18T22:10:57.932946Z","steps":["trace[405708037] 'agreement among raft nodes before linearized reading' (duration: 399.510784ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:57.932973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:10:57.533374Z","time spent":"399.592954ms","remote":"127.0.0.1:46910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"info","ts":"2026-04-18T22:10:57.93269Z","caller":"traceutil/trace.go:171","msg":"trace[1041545008] transaction","detail":"{read_only:false; response_revision:2130; number_of_response:1; }","duration":"640.100427ms","start":"2026-04-18T22:10:57.29258Z","end":"2026-04-18T22:10:57.932681Z","steps":["trace[1041545008] 'process raft request' (duration: 639.375127ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:57.933072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.099169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-18T22:10:57.933119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:10:57.292541Z","time spent":"640.506204ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:10:57.932741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"635.277947ms","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-04-18T22:10:57.933458Z","caller":"traceutil/trace.go:171","msg":"trace[38768070] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2134; }","duration":"636.005589ms","start":"2026-04-18T22:10:57.29743Z","end":"2026-04-18T22:10:57.933436Z","steps":["trace[38768070] 'agreement among raft nodes before linearized reading' (duration: 635.247427ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:57.933565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:10:57.29742Z","time spent":"636.130621ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-18T22:10:57.934126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.437428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-18T22:10:57.934239Z","caller":"traceutil/trace.go:171","msg":"trace[116939499] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:2134; }","duration":"181.583869ms","start":"2026-04-18T22:10:57.752643Z","end":"2026-04-18T22:10:57.934227Z","steps":["trace[116939499] 'agreement among raft nodes before linearized reading' (duration: 180.233219ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:10:57.934699Z","caller":"traceutil/trace.go:171","msg":"trace[893295084] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:2134; }","duration":"426.242681ms","start":"2026-04-18T22:10:57.506884Z","end":"2026-04-18T22:10:57.933127Z","steps":["trace[893295084] 'agreement among raft nodes before linearized reading' (duration: 425.940546ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:10:57.934825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:10:57.506862Z","time spent":"427.944036ms","remote":"127.0.0.1:60910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":4,"response size":30,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"info","ts":"2026-04-18T22:11:15.530528Z","caller":"traceutil/trace.go:171","msg":"trace[395084082] transaction","detail":"{read_only:false; response_revision:2221; number_of_response:1; }","duration":"195.492371ms","start":"2026-04-18T22:11:15.335003Z","end":"2026-04-18T22:11:15.530495Z","steps":["trace[395084082] 'process raft request' (duration: 107.964771ms)","trace[395084082] 'compare' (duration: 87.269797ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:11:15.530501Z","caller":"traceutil/trace.go:171","msg":"trace[1696410421] linearizableReadLoop","detail":"{readStateIndex:2306; appliedIndex:2303; }","duration":"127.007633ms","start":"2026-04-18T22:11:15.403468Z","end":"2026-04-18T22:11:15.530476Z","steps":["trace[1696410421] 'read index received' (duration: 39.511784ms)","trace[1696410421] 'applied index is now lower than readState.Index' (duration: 87.494949ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:11:15.530677Z","caller":"traceutil/trace.go:171","msg":"trace[433595872] transaction","detail":"{read_only:false; response_revision:2222; number_of_response:1; }","duration":"182.735202ms","start":"2026-04-18T22:11:15.347924Z","end":"2026-04-18T22:11:15.530659Z","steps":["trace[433595872] 'process raft request' (duration: 182.476439ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:11:15.530789Z","caller":"traceutil/trace.go:171","msg":"trace[1350477371] transaction","detail":"{read_only:false; response_revision:2223; number_of_response:1; }","duration":"139.807263ms","start":"2026-04-18T22:11:15.390975Z","end":"2026-04-18T22:11:15.530783Z","steps":["trace[1350477371] 'process raft request' (duration: 139.467049ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:11:15.530894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.399039ms","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-04-18T22:11:15.530984Z","caller":"traceutil/trace.go:171","msg":"trace[863218941] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2223; }","duration":"127.54968ms","start":"2026-04-18T22:11:15.403415Z","end":"2026-04-18T22:11:15.530965Z","steps":["trace[863218941] 'agreement among raft nodes before linearized reading' (duration: 127.289087ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:11:39.720836Z","caller":"traceutil/trace.go:171","msg":"trace[1156566686] transaction","detail":"{read_only:false; response_revision:2361; number_of_response:1; }","duration":"100.089649ms","start":"2026-04-18T22:11:39.620726Z","end":"2026-04-18T22:11:39.720815Z","steps":["trace[1156566686] 'process raft request' (duration: 98.812574ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:11:40.279536Z","caller":"traceutil/trace.go:171","msg":"trace[743378638] transaction","detail":"{read_only:false; response_revision:2363; number_of_response:1; }","duration":"161.106821ms","start":"2026-04-18T22:11:40.118417Z","end":"2026-04-18T22:11:40.279524Z","steps":["trace[743378638] 'process raft request' (duration: 161.04734ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:11:40.28051Z","caller":"traceutil/trace.go:171","msg":"trace[595924938] linearizableReadLoop","detail":"{readStateIndex:2453; appliedIndex:2452; }","duration":"159.42988ms","start":"2026-04-18T22:11:40.121052Z","end":"2026-04-18T22:11:40.280482Z","steps":["trace[595924938] 'read index received' (duration: 158.510609ms)","trace[595924938] 'applied index is now lower than readState.Index' (duration: 917.751µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:11:40.280572Z","caller":"traceutil/trace.go:171","msg":"trace[1528401974] transaction","detail":"{read_only:false; response_revision:2364; number_of_response:1; }","duration":"160.101009ms","start":"2026-04-18T22:11:40.120442Z","end":"2026-04-18T22:11:40.280543Z","steps":["trace[1528401974] 'process raft request' (duration: 159.883736ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:11:40.280848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.765884ms","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-04-18T22:11:40.281271Z","caller":"traceutil/trace.go:171","msg":"trace[2009783049] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2364; }","duration":"160.224781ms","start":"2026-04-18T22:11:40.121029Z","end":"2026-04-18T22:11:40.281254Z","steps":["trace[2009783049] 'agreement among raft nodes before linearized reading' (duration: 159.662274ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:11:40.280988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.871196ms","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-04-18T22:11:40.281373Z","caller":"traceutil/trace.go:171","msg":"trace[235943656] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2364; }","duration":"155.276901ms","start":"2026-04-18T22:11:40.126077Z","end":"2026-04-18T22:11:40.281354Z","steps":["trace[235943656] 'agreement among raft nodes before linearized reading' (duration: 154.654423ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:11:40.280984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.710775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-18T22:11:40.281435Z","caller":"traceutil/trace.go:171","msg":"trace[2099368373] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2364; }","duration":"151.185601ms","start":"2026-04-18T22:11:40.13024Z","end":"2026-04-18T22:11:40.281426Z","steps":["trace[2099368373] 'agreement among raft nodes before linearized reading' (duration: 150.594183ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:11:42.235537Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10836959925205552981,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-18T22:11:42.236111Z","caller":"traceutil/trace.go:171","msg":"trace[1659472876] transaction","detail":"{read_only:false; response_revision:2369; number_of_response:1; }","duration":"541.536054ms","start":"2026-04-18T22:11:41.694554Z","end":"2026-04-18T22:11:42.23609Z","steps":["trace[1659472876] 'process raft request' (duration: 541.408823ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:11:42.236248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:11:41.694517Z","time spent":"541.657715ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:11:42.237127Z","caller":"traceutil/trace.go:171","msg":"trace[884438865] linearizableReadLoop","detail":"{readStateIndex:2460; appliedIndex:2457; }","duration":"502.125561ms","start":"2026-04-18T22:11:41.734981Z","end":"2026-04-18T22:11:42.237107Z","steps":["trace[884438865] 'read index received' (duration: 500.991607ms)","trace[884438865] 'applied index is now lower than readState.Index' (duration: 1.133134ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:11:42.237443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.229191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:11:42.237492Z","caller":"traceutil/trace.go:171","msg":"trace[447129020] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:2371; }","duration":"442.354903ms","start":"2026-04-18T22:11:41.795123Z","end":"2026-04-18T22:11:42.237478Z","steps":["trace[447129020] 'agreement among raft nodes before linearized reading' (duration: 442.269102ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:11:42.237528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:11:41.79511Z","time spent":"442.407254ms","remote":"127.0.0.1:49584","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true "} {"level":"warn","ts":"2026-04-18T22:11:42.237452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.440064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5428"} {"level":"info","ts":"2026-04-18T22:11:42.237675Z","caller":"traceutil/trace.go:171","msg":"trace[1748019846] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2371; }","duration":"502.718658ms","start":"2026-04-18T22:11:41.734933Z","end":"2026-04-18T22:11:42.237652Z","steps":["trace[1748019846] 'agreement among raft nodes before linearized reading' (duration: 502.307423ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:11:42.23776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:11:41.734915Z","time spent":"502.830109ms","remote":"127.0.0.1:49648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5451,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-04-18T22:11:42.238053Z","caller":"traceutil/trace.go:171","msg":"trace[2105106766] transaction","detail":"{read_only:false; response_revision:2370; number_of_response:1; }","duration":"513.135403ms","start":"2026-04-18T22:11:41.724904Z","end":"2026-04-18T22:11:42.23804Z","steps":["trace[2105106766] 'process raft request' (duration: 512.02521ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:11:42.238195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:11:41.724879Z","time spent":"513.250394ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:11:42.2382Z","caller":"traceutil/trace.go:171","msg":"trace[558547090] transaction","detail":"{read_only:false; response_revision:2371; number_of_response:1; }","duration":"158.426815ms","start":"2026-04-18T22:11:42.079746Z","end":"2026-04-18T22:11:42.238172Z","steps":["trace[558547090] 'process raft request' (duration: 157.304322ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:11:42.58389Z","caller":"traceutil/trace.go:171","msg":"trace[1734034159] transaction","detail":"{read_only:false; response_revision:2372; number_of_response:1; }","duration":"297.163027ms","start":"2026-04-18T22:11:42.286696Z","end":"2026-04-18T22:11:42.583859Z","steps":["trace[1734034159] 'process raft request' (duration: 292.256218ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:11:42.583939Z","caller":"traceutil/trace.go:171","msg":"trace[364789997] transaction","detail":"{read_only:false; response_revision:2374; number_of_response:1; }","duration":"251.167735ms","start":"2026-04-18T22:11:42.332748Z","end":"2026-04-18T22:11:42.583916Z","steps":["trace[364789997] 'process raft request' (duration: 251.096954ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:11:42.584041Z","caller":"traceutil/trace.go:171","msg":"trace[1143660854] linearizableReadLoop","detail":"{readStateIndex:2461; appliedIndex:2460; }","duration":"296.111744ms","start":"2026-04-18T22:11:42.287908Z","end":"2026-04-18T22:11:42.58402Z","steps":["trace[1143660854] 'read index received' (duration: 291.053614ms)","trace[1143660854] 'applied index is now lower than readState.Index' (duration: 5.05604ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:11:42.584146Z","caller":"traceutil/trace.go:171","msg":"trace[1188840427] transaction","detail":"{read_only:false; response_revision:2373; number_of_response:1; }","duration":"295.70662ms","start":"2026-04-18T22:11:42.288413Z","end":"2026-04-18T22:11:42.58412Z","steps":["trace[1188840427] 'process raft request' (duration: 295.336884ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:11:42.584543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.61352ms","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-04-18T22:11:42.584611Z","caller":"traceutil/trace.go:171","msg":"trace[712751379] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2374; }","duration":"296.717441ms","start":"2026-04-18T22:11:42.287881Z","end":"2026-04-18T22:11:42.584598Z","steps":["trace[712751379] 'agreement among raft nodes before linearized reading' (duration: 296.251796ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:11:42.584889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.448647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-04-18T22:11:42.585262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.915704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:11:42.585309Z","caller":"traceutil/trace.go:171","msg":"trace[404363375] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2375; }","duration":"134.981505ms","start":"2026-04-18T22:11:42.450317Z","end":"2026-04-18T22:11:42.585298Z","steps":["trace[404363375] 'agreement among raft nodes before linearized reading' (duration: 134.883614ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:11:42.58534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.615839ms","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-04-18T22:11:42.585428Z","caller":"traceutil/trace.go:171","msg":"trace[1213362716] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2375; }","duration":"295.72912ms","start":"2026-04-18T22:11:42.289685Z","end":"2026-04-18T22:11:42.585414Z","steps":["trace[1213362716] 'agreement among raft nodes before linearized reading' (duration: 295.555528ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:11:42.585476Z","caller":"traceutil/trace.go:171","msg":"trace[1409113179] transaction","detail":"{read_only:false; response_revision:2375; number_of_response:1; }","duration":"141.591355ms","start":"2026-04-18T22:11:42.442857Z","end":"2026-04-18T22:11:42.584448Z","steps":["trace[1409113179] 'process raft request' (duration: 141.021588ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:11:42.584957Z","caller":"traceutil/trace.go:171","msg":"trace[1893276660] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2375; }","duration":"295.563248ms","start":"2026-04-18T22:11:42.289378Z","end":"2026-04-18T22:11:42.584941Z","steps":["trace[1893276660] 'agreement among raft nodes before linearized reading' (duration: 295.373296ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:12:01.168187Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10836959925205553380,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-18T22:12:01.298307Z","caller":"traceutil/trace.go:171","msg":"trace[1382812938] transaction","detail":"{read_only:false; response_revision:2565; number_of_response:1; }","duration":"997.218069ms","start":"2026-04-18T22:12:00.301065Z","end":"2026-04-18T22:12:01.298283Z","steps":["trace[1382812938] 'process raft request' (duration: 997.075058ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:12:01.298462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:12:00.301045Z","time spent":"997.325ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:12:01.415393Z","caller":"traceutil/trace.go:171","msg":"trace[40330248] transaction","detail":"{read_only:false; response_revision:2566; number_of_response:1; }","duration":"1.101013195s","start":"2026-04-18T22:12:00.314353Z","end":"2026-04-18T22:12:01.415367Z","steps":["trace[40330248] 'process raft request' (duration: 1.097737778s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:12:01.415632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:12:00.314338Z","time spent":"1.101135428s","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:12:01.415761Z","caller":"traceutil/trace.go:171","msg":"trace[1683802354] linearizableReadLoop","detail":"{readStateIndex:2661; appliedIndex:2658; }","duration":"748.211004ms","start":"2026-04-18T22:12:00.667524Z","end":"2026-04-18T22:12:01.415735Z","steps":["trace[1683802354] 'read index received' (duration: 630.611451ms)","trace[1683802354] 'applied index is now lower than readState.Index' (duration: 117.597553ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:12:01.415927Z","caller":"traceutil/trace.go:171","msg":"trace[1465353878] transaction","detail":"{read_only:false; response_revision:2567; number_of_response:1; }","duration":"1.100658182s","start":"2026-04-18T22:12:00.315247Z","end":"2026-04-18T22:12:01.415905Z","steps":["trace[1465353878] 'process raft request' (duration: 1.100073746s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:12:01.416057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:12:00.315225Z","time spent":"1.100757613s","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:12:01.416146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"748.60504ms","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-04-18T22:12:01.416224Z","caller":"traceutil/trace.go:171","msg":"trace[1436967194] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2567; }","duration":"748.751641ms","start":"2026-04-18T22:12:00.667454Z","end":"2026-04-18T22:12:01.416206Z","steps":["trace[1436967194] 'agreement among raft nodes before linearized reading' (duration: 748.529698ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:12:01.416269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:12:00.667432Z","time spent":"748.827641ms","remote":"127.0.0.1:60868","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-04-18T22:12:01.416441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"650.103119ms","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-04-18T22:12:01.416501Z","caller":"traceutil/trace.go:171","msg":"trace[2107355707] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2567; }","duration":"650.199401ms","start":"2026-04-18T22:12:00.766288Z","end":"2026-04-18T22:12:01.416487Z","steps":["trace[2107355707] 'agreement among raft nodes before linearized reading' (duration: 649.700635ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:12:01.416548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"593.843339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:12:01.416595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:12:00.766272Z","time spent":"650.309042ms","remote":"127.0.0.1:60782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1392,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"info","ts":"2026-04-18T22:12:01.416606Z","caller":"traceutil/trace.go:171","msg":"trace[1872407239] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2567; }","duration":"593.929121ms","start":"2026-04-18T22:12:00.822661Z","end":"2026-04-18T22:12:01.41659Z","steps":["trace[1872407239] 'agreement among raft nodes before linearized reading' (duration: 593.85316ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:12:01.416563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"741.58793ms","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-04-18T22:12:01.416765Z","caller":"traceutil/trace.go:171","msg":"trace[1032735259] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2567; }","duration":"741.907924ms","start":"2026-04-18T22:12:00.674847Z","end":"2026-04-18T22:12:01.416755Z","steps":["trace[1032735259] 'agreement among raft nodes before linearized reading' (duration: 741.119575ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:12:01.416825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"736.40415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-18T22:12:01.41668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:12:00.822646Z","time spent":"594.023052ms","remote":"127.0.0.1:60602","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-04-18T22:12:01.416733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"741.116213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-18T22:12:01.417009Z","caller":"traceutil/trace.go:171","msg":"trace[1584467275] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2567; }","duration":"736.511632ms","start":"2026-04-18T22:12:00.680406Z","end":"2026-04-18T22:12:01.416918Z","steps":["trace[1584467275] 'agreement among raft nodes before linearized reading' (duration: 736.267229ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:12:01.416773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"741.778242ms","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-04-18T22:12:01.417028Z","caller":"traceutil/trace.go:171","msg":"trace[2068668046] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2567; }","duration":"741.425458ms","start":"2026-04-18T22:12:00.675583Z","end":"2026-04-18T22:12:01.417008Z","steps":["trace[2068668046] 'agreement among raft nodes before linearized reading' (duration: 740.952112ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:12:01.417059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:12:00.68037Z","time spent":"736.676764ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-18T22:12:01.417087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:12:00.675576Z","time spent":"741.494978ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-18T22:12:01.417098Z","caller":"traceutil/trace.go:171","msg":"trace[889101000] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2567; }","duration":"742.134946ms","start":"2026-04-18T22:12:00.674924Z","end":"2026-04-18T22:12:01.417059Z","steps":["trace[889101000] 'agreement among raft nodes before linearized reading' (duration: 741.632601ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:12:01.41715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:12:00.674905Z","time spent":"742.228687ms","remote":"127.0.0.1:60868","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-04-18T22:12:01.416975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:12:00.674825Z","time spent":"742.044995ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-18T22:12:34.060793Z","caller":"traceutil/trace.go:171","msg":"trace[459175812] transaction","detail":"{read_only:false; response_revision:2746; number_of_response:1; }","duration":"436.833341ms","start":"2026-04-18T22:12:33.623925Z","end":"2026-04-18T22:12:34.060759Z","steps":["trace[459175812] 'process raft request' (duration: 377.206089ms)","trace[459175812] 'compare' (duration: 59.43872ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:12:34.061308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:12:33.623903Z","time spent":"436.960272ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:12:34.063878Z","caller":"traceutil/trace.go:171","msg":"trace[1978042854] linearizableReadLoop","detail":"{readStateIndex:2851; appliedIndex:2846; }","duration":"240.303142ms","start":"2026-04-18T22:12:33.823555Z","end":"2026-04-18T22:12:34.063858Z","steps":["trace[1978042854] 'read index received' (duration: 177.595717ms)","trace[1978042854] 'applied index is now lower than readState.Index' (duration: 62.706605ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:12:34.063917Z","caller":"traceutil/trace.go:171","msg":"trace[1007366637] transaction","detail":"{read_only:false; response_revision:2749; number_of_response:1; }","duration":"438.117165ms","start":"2026-04-18T22:12:33.625786Z","end":"2026-04-18T22:12:34.063903Z","steps":["trace[1007366637] 'process raft request' (duration: 438.012114ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:12:34.064006Z","caller":"traceutil/trace.go:171","msg":"trace[603715095] transaction","detail":"{read_only:false; response_revision:2750; number_of_response:1; }","duration":"437.350526ms","start":"2026-04-18T22:12:33.626636Z","end":"2026-04-18T22:12:34.063987Z","steps":["trace[603715095] 'process raft request' (duration: 437.193185ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:12:34.064022Z","caller":"traceutil/trace.go:171","msg":"trace[388755862] transaction","detail":"{read_only:false; response_revision:2748; number_of_response:1; }","duration":"438.222546ms","start":"2026-04-18T22:12:33.625734Z","end":"2026-04-18T22:12:34.063956Z","steps":["trace[388755862] 'process raft request' (duration: 438.030584ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:12:34.064279Z","caller":"traceutil/trace.go:171","msg":"trace[1877637535] transaction","detail":"{read_only:false; response_revision:2747; number_of_response:1; }","duration":"438.170765ms","start":"2026-04-18T22:12:33.625651Z","end":"2026-04-18T22:12:34.063821Z","steps":["trace[1877637535] 'process raft request' (duration: 438.017803ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:12:34.064388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:12:33.625632Z","time spent":"438.720492ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:12:34.0641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:12:33.626599Z","time spent":"437.458858ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:12:34.064176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:12:33.62578Z","time spent":"438.246916ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:12:34.064534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:12:33.625725Z","time spent":"438.576531ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:12:34.065313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.743608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:12:34.065394Z","caller":"traceutil/trace.go:171","msg":"trace[953005728] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2750; }","duration":"241.8755ms","start":"2026-04-18T22:12:33.823501Z","end":"2026-04-18T22:12:34.065376Z","steps":["trace[953005728] 'agreement among raft nodes before linearized reading' (duration: 240.451204ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:12:35.028162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.282048ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T22:12:35.028915Z","caller":"traceutil/trace.go:171","msg":"trace[1585811913] transaction","detail":"{read_only:false; response_revision:2751; number_of_response:1; }","duration":"960.53891ms","start":"2026-04-18T22:12:34.068326Z","end":"2026-04-18T22:12:35.028865Z","steps":["trace[1585811913] 'process raft request' (duration: 541.510595ms)","trace[1585811913] 'compare' (duration: 418.215457ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:12:35.029059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:12:34.068304Z","time spent":"960.683822ms","remote":"127.0.0.1:60668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":766,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:12:35.118325Z","caller":"traceutil/trace.go:171","msg":"trace[14511417] linearizableReadLoop","detail":"{readStateIndex:2853; appliedIndex:2851; }","duration":"351.555079ms","start":"2026-04-18T22:12:34.766726Z","end":"2026-04-18T22:12:35.118281Z","steps":["trace[14511417] 'read index received' (duration: 36.411µs)","trace[14511417] 'applied index is now lower than readState.Index' (duration: 351.516218ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:12:35.118662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.901396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:12:35.11876Z","caller":"traceutil/trace.go:171","msg":"trace[1184794867] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2751; }","duration":"295.028427ms","start":"2026-04-18T22:12:34.823712Z","end":"2026-04-18T22:12:35.11874Z","steps":["trace[1184794867] 'agreement among raft nodes before linearized reading' (duration: 294.846745ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:12:35.118776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.016053ms","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-04-18T22:12:35.11883Z","caller":"traceutil/trace.go:171","msg":"trace[1753707909] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2751; }","duration":"352.138874ms","start":"2026-04-18T22:12:34.766673Z","end":"2026-04-18T22:12:35.118812Z","steps":["trace[1753707909] 'agreement among raft nodes before linearized reading' (duration: 351.846031ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:12:35.118885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:12:34.766651Z","time spent":"352.220795ms","remote":"127.0.0.1:60782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1392,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"info","ts":"2026-04-18T22:14:24.767726Z","caller":"traceutil/trace.go:171","msg":"trace[105920016] transaction","detail":"{read_only:false; response_revision:3411; number_of_response:1; }","duration":"100.76222ms","start":"2026-04-18T22:14:24.666945Z","end":"2026-04-18T22:14:24.767708Z","steps":["trace[105920016] 'process raft request' (duration: 100.620665ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:15:05.089334Z","caller":"traceutil/trace.go:171","msg":"trace[252876643] transaction","detail":"{read_only:false; response_revision:3632; number_of_response:1; }","duration":"117.618738ms","start":"2026-04-18T22:15:04.971688Z","end":"2026-04-18T22:15:05.089307Z","steps":["trace[252876643] 'process raft request' (duration: 30.338593ms)","trace[252876643] 'compare' (duration: 86.71743ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:15:05.089784Z","caller":"traceutil/trace.go:171","msg":"trace[1196521211] transaction","detail":"{read_only:false; response_revision:3633; number_of_response:1; }","duration":"116.013477ms","start":"2026-04-18T22:15:04.973752Z","end":"2026-04-18T22:15:05.089765Z","steps":["trace[1196521211] 'process raft request' (duration: 115.505274ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:15:05.089781Z","caller":"traceutil/trace.go:171","msg":"trace[1165465410] transaction","detail":"{read_only:false; response_revision:3634; number_of_response:1; }","duration":"115.347119ms","start":"2026-04-18T22:15:04.974339Z","end":"2026-04-18T22:15:05.089686Z","steps":["trace[1165465410] 'process raft request' (duration: 115.161264ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:15:05.425142Z","caller":"traceutil/trace.go:171","msg":"trace[1292301055] transaction","detail":"{read_only:false; response_revision:3636; number_of_response:1; }","duration":"152.879584ms","start":"2026-04-18T22:15:05.272236Z","end":"2026-04-18T22:15:05.425116Z","steps":["trace[1292301055] 'process raft request' (duration: 152.659328ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:09.976614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.264677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/ingress-nginx/ingress-nginx-controller-r6pk5.18a792fdb3cb249f\" ","response":"range_response_count:1 size:765"} {"level":"info","ts":"2026-04-18T22:16:09.976705Z","caller":"traceutil/trace.go:171","msg":"trace[1436536557] range","detail":"{range_begin:/registry/events/ingress-nginx/ingress-nginx-controller-r6pk5.18a792fdb3cb249f; range_end:; response_count:1; response_revision:4414; }","duration":"109.40662ms","start":"2026-04-18T22:16:09.86728Z","end":"2026-04-18T22:16:09.976686Z","steps":["trace[1436536557] 'range keys from in-memory index tree' (duration: 109.092234ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:11.654835Z","caller":"traceutil/trace.go:171","msg":"trace[2004622791] transaction","detail":"{read_only:false; response_revision:4426; number_of_response:1; }","duration":"202.375233ms","start":"2026-04-18T22:16:11.452442Z","end":"2026-04-18T22:16:11.654817Z","steps":["trace[2004622791] 'process raft request' (duration: 202.277521ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:11.66356Z","caller":"traceutil/trace.go:171","msg":"trace[2065493925] transaction","detail":"{read_only:false; response_revision:4427; number_of_response:1; }","duration":"210.780987ms","start":"2026-04-18T22:16:11.452767Z","end":"2026-04-18T22:16:11.663548Z","steps":["trace[2065493925] 'process raft request' (duration: 210.669035ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:11.663737Z","caller":"traceutil/trace.go:171","msg":"trace[35740620] linearizableReadLoop","detail":"{readStateIndex:4597; appliedIndex:4595; }","duration":"159.897825ms","start":"2026-04-18T22:16:11.503814Z","end":"2026-04-18T22:16:11.663712Z","steps":["trace[35740620] 'read index received' (duration: 150.931078ms)","trace[35740620] 'applied index is now lower than readState.Index' (duration: 8.965596ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:16:11.663935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.108059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-18T22:16:11.663967Z","caller":"traceutil/trace.go:171","msg":"trace[1182183273] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4428; }","duration":"160.16915ms","start":"2026-04-18T22:16:11.503787Z","end":"2026-04-18T22:16:11.663957Z","steps":["trace[1182183273] 'agreement among raft nodes before linearized reading' (duration: 160.009107ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:14.830185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.084979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:16:14.830269Z","caller":"traceutil/trace.go:171","msg":"trace[2124944249] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1; range_end:; response_count:0; response_revision:4531; }","duration":"254.197551ms","start":"2026-04-18T22:16:14.576051Z","end":"2026-04-18T22:16:14.830248Z","steps":["trace[2124944249] 'range keys from in-memory index tree' (duration: 254.033867ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:14.889642Z","caller":"traceutil/trace.go:171","msg":"trace[800174826] linearizableReadLoop","detail":"{readStateIndex:4704; appliedIndex:4702; }","duration":"198.64074ms","start":"2026-04-18T22:16:14.69098Z","end":"2026-04-18T22:16:14.889621Z","steps":["trace[800174826] 'read index received' (duration: 129.782105ms)","trace[800174826] 'applied index is now lower than readState.Index' (duration: 68.857685ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:16:14.889868Z","caller":"traceutil/trace.go:171","msg":"trace[1177196324] transaction","detail":"{read_only:false; response_revision:4532; number_of_response:1; }","duration":"258.387527ms","start":"2026-04-18T22:16:14.631469Z","end":"2026-04-18T22:16:14.889857Z","steps":["trace[1177196324] 'process raft request' (duration: 257.864526ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:14.89014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.14976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0.18a79355acb40280\" ","response":"range_response_count:1 size:1179"} {"level":"info","ts":"2026-04-18T22:16:14.89019Z","caller":"traceutil/trace.go:171","msg":"trace[1778731325] range","detail":"{range_begin:/registry/events/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0.18a79355acb40280; range_end:; response_count:1; response_revision:4532; }","duration":"199.222561ms","start":"2026-04-18T22:16:14.690949Z","end":"2026-04-18T22:16:14.890171Z","steps":["trace[1778731325] 'agreement among raft nodes before linearized reading' (duration: 199.065578ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:14.890437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.689381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6916fd66-8d0b-46d5-bda4-2ed0fa604ab4\" ","response":"range_response_count:1 size:3774"} {"level":"info","ts":"2026-04-18T22:16:14.890484Z","caller":"traceutil/trace.go:171","msg":"trace[39943069] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6916fd66-8d0b-46d5-bda4-2ed0fa604ab4; range_end:; response_count:1; response_revision:4532; }","duration":"163.755183ms","start":"2026-04-18T22:16:14.726717Z","end":"2026-04-18T22:16:14.890472Z","steps":["trace[39943069] 'agreement among raft nodes before linearized reading' (duration: 163.646261ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:14.997555Z","caller":"traceutil/trace.go:171","msg":"trace[363854630] linearizableReadLoop","detail":"{readStateIndex:4705; appliedIndex:4704; }","duration":"101.557286ms","start":"2026-04-18T22:16:14.895983Z","end":"2026-04-18T22:16:14.997541Z","steps":["trace[363854630] 'read index received' (duration: 90.5731ms)","trace[363854630] 'applied index is now lower than readState.Index' (duration: 10.983386ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:16:14.997649Z","caller":"traceutil/trace.go:171","msg":"trace[1646684502] transaction","detail":"{read_only:false; response_revision:4533; number_of_response:1; }","duration":"103.68407ms","start":"2026-04-18T22:16:14.893953Z","end":"2026-04-18T22:16:14.997637Z","steps":["trace[1646684502] 'process raft request' (duration: 92.574492ms)","trace[1646684502] 'compare' (duration: 10.907894ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:16:14.998003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.008996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"} {"level":"info","ts":"2026-04-18T22:16:14.998045Z","caller":"traceutil/trace.go:171","msg":"trace[646222148] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:4533; }","duration":"102.073557ms","start":"2026-04-18T22:16:14.895961Z","end":"2026-04-18T22:16:14.998035Z","steps":["trace[646222148] 'agreement among raft nodes before linearized reading' (duration: 101.960895ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:16.594729Z","caller":"traceutil/trace.go:171","msg":"trace[673909450] linearizableReadLoop","detail":"{readStateIndex:4755; appliedIndex:4754; }","duration":"106.320571ms","start":"2026-04-18T22:16:16.488381Z","end":"2026-04-18T22:16:16.594702Z","steps":["trace[673909450] 'read index received' (duration: 106.006975ms)","trace[673909450] 'applied index is now lower than readState.Index' (duration: 312.366µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:16:16.594966Z","caller":"traceutil/trace.go:171","msg":"trace[1069885455] transaction","detail":"{read_only:false; response_revision:4581; number_of_response:1; }","duration":"183.08214ms","start":"2026-04-18T22:16:16.411855Z","end":"2026-04-18T22:16:16.594937Z","steps":["trace[1069885455] 'process raft request' (duration: 182.60729ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:16.595769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.363042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2193165"} {"level":"info","ts":"2026-04-18T22:16:16.595824Z","caller":"traceutil/trace.go:171","msg":"trace[764036525] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4581; }","duration":"107.462864ms","start":"2026-04-18T22:16:16.488348Z","end":"2026-04-18T22:16:16.595811Z","steps":["trace[764036525] 'agreement among raft nodes before linearized reading' (duration: 106.458814ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:17.612956Z","caller":"traceutil/trace.go:171","msg":"trace[708604425] transaction","detail":"{read_only:false; response_revision:4591; number_of_response:1; }","duration":"233.830901ms","start":"2026-04-18T22:16:17.379093Z","end":"2026-04-18T22:16:17.612923Z","steps":["trace[708604425] 'process raft request' (duration: 233.666207ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:17.637371Z","caller":"traceutil/trace.go:171","msg":"trace[1025794598] linearizableReadLoop","detail":"{readStateIndex:4766; appliedIndex:4764; }","duration":"149.225328ms","start":"2026-04-18T22:16:17.488119Z","end":"2026-04-18T22:16:17.637344Z","steps":["trace[1025794598] 'read index received' (duration: 124.7538ms)","trace[1025794598] 'applied index is now lower than readState.Index' (duration: 24.470528ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:16:17.637505Z","caller":"traceutil/trace.go:171","msg":"trace[25199861] transaction","detail":"{read_only:false; response_revision:4592; number_of_response:1; }","duration":"254.943881ms","start":"2026-04-18T22:16:17.382511Z","end":"2026-04-18T22:16:17.637455Z","steps":["trace[25199861] 'process raft request' (duration: 254.669376ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:17.63759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.450442ms","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-04-18T22:16:17.637635Z","caller":"traceutil/trace.go:171","msg":"trace[140786835] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4592; }","duration":"149.572705ms","start":"2026-04-18T22:16:17.488049Z","end":"2026-04-18T22:16:17.637621Z","steps":["trace[140786835] 'agreement among raft nodes before linearized reading' (duration: 149.392571ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:23.55968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.60025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-90f337bb-1d90-4ef4-a0a7-1bd2a324a821\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-04-18T22:16:23.559957Z","caller":"traceutil/trace.go:171","msg":"trace[1654985893] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-90f337bb-1d90-4ef4-a0a7-1bd2a324a821; range_end:; response_count:1; response_revision:4724; }","duration":"529.886097ms","start":"2026-04-18T22:16:23.030032Z","end":"2026-04-18T22:16:23.559918Z","steps":["trace[1654985893] 'range keys from in-memory index tree' (duration: 529.412637ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:23.560094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:23.03001Z","time spent":"530.06793ms","remote":"127.0.0.1:60770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3669,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-90f337bb-1d90-4ef4-a0a7-1bd2a324a821\" "} {"level":"warn","ts":"2026-04-18T22:16:23.559685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.385093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-04-18T22:16:23.560353Z","caller":"traceutil/trace.go:171","msg":"trace[1049838279] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:4724; }","duration":"319.113297ms","start":"2026-04-18T22:16:23.241225Z","end":"2026-04-18T22:16:23.560339Z","steps":["trace[1049838279] 'range keys from in-memory index tree' (duration: 318.119557ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:23.56045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:23.241202Z","time spent":"319.23268ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":553,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"warn","ts":"2026-04-18T22:16:23.559691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.176057ms","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-04-18T22:16:23.560618Z","caller":"traceutil/trace.go:171","msg":"trace[56341969] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4724; }","duration":"172.143695ms","start":"2026-04-18T22:16:23.388446Z","end":"2026-04-18T22:16:23.56059Z","steps":["trace[56341969] 'range keys from in-memory index tree' (duration: 171.013153ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:23.739894Z","caller":"traceutil/trace.go:171","msg":"trace[710322784] transaction","detail":"{read_only:false; response_revision:4725; number_of_response:1; }","duration":"171.831519ms","start":"2026-04-18T22:16:23.568038Z","end":"2026-04-18T22:16:23.73987Z","steps":["trace[710322784] 'process raft request' (duration: 171.673126ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:23.947297Z","caller":"traceutil/trace.go:171","msg":"trace[441182332] transaction","detail":"{read_only:false; response_revision:4726; number_of_response:1; }","duration":"378.76178ms","start":"2026-04-18T22:16:23.568518Z","end":"2026-04-18T22:16:23.94728Z","steps":["trace[441182332] 'process raft request' (duration: 378.611247ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:23.947468Z","caller":"traceutil/trace.go:171","msg":"trace[473028453] transaction","detail":"{read_only:false; response_revision:4727; number_of_response:1; }","duration":"378.026517ms","start":"2026-04-18T22:16:23.569422Z","end":"2026-04-18T22:16:23.947448Z","steps":["trace[473028453] 'process raft request' (duration: 377.816953ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:23.947447Z","caller":"traceutil/trace.go:171","msg":"trace[2074819924] linearizableReadLoop","detail":"{readStateIndex:4905; appliedIndex:4902; }","duration":"376.486205ms","start":"2026-04-18T22:16:23.570936Z","end":"2026-04-18T22:16:23.947422Z","steps":["trace[2074819924] 'read index received' (duration: 168.8557ms)","trace[2074819924] 'applied index is now lower than readState.Index' (duration: 207.628925ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:16:23.947608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:23.569414Z","time spent":"378.110948ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:16:23.947662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.71032ms","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-04-18T22:16:23.947725Z","caller":"traceutil/trace.go:171","msg":"trace[426555655] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4727; }","duration":"376.793923ms","start":"2026-04-18T22:16:23.570908Z","end":"2026-04-18T22:16:23.947702Z","steps":["trace[426555655] 'agreement among raft nodes before linearized reading' (duration: 376.635329ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:23.947762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:23.5709Z","time spent":"376.853994ms","remote":"127.0.0.1:60770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":1,"response size":12998,"request content":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"warn","ts":"2026-04-18T22:16:23.947768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.699257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-18T22:16:23.947817Z","caller":"traceutil/trace.go:171","msg":"trace[1447973799] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4727; }","duration":"147.762437ms","start":"2026-04-18T22:16:23.800028Z","end":"2026-04-18T22:16:23.947791Z","steps":["trace[1447973799] 'agreement among raft nodes before linearized reading' (duration: 147.630084ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:23.947822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.692367ms","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-04-18T22:16:23.947875Z","caller":"traceutil/trace.go:171","msg":"trace[644224428] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4727; }","duration":"147.773778ms","start":"2026-04-18T22:16:23.80009Z","end":"2026-04-18T22:16:23.947864Z","steps":["trace[644224428] 'agreement among raft nodes before linearized reading' (duration: 147.654226ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:23.947982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.444312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-7bcf85cfcc-rkl6x.18a7935796e5b89d\" ","response":"range_response_count:1 size:898"} {"level":"warn","ts":"2026-04-18T22:16:23.948026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.847411ms","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-04-18T22:16:23.948066Z","caller":"traceutil/trace.go:171","msg":"trace[770669595] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4727; }","duration":"232.928783ms","start":"2026-04-18T22:16:23.715127Z","end":"2026-04-18T22:16:23.948056Z","steps":["trace[770669595] 'agreement among raft nodes before linearized reading' (duration: 232.830751ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:23.948107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.887482ms","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-04-18T22:16:23.948027Z","caller":"traceutil/trace.go:171","msg":"trace[304968411] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-7bcf85cfcc-rkl6x.18a7935796e5b89d; range_end:; response_count:1; response_revision:4727; }","duration":"204.518913ms","start":"2026-04-18T22:16:23.743495Z","end":"2026-04-18T22:16:23.948014Z","steps":["trace[304968411] 'agreement among raft nodes before linearized reading' (duration: 204.416531ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:23.948144Z","caller":"traceutil/trace.go:171","msg":"trace[293001385] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4727; }","duration":"193.954003ms","start":"2026-04-18T22:16:23.75418Z","end":"2026-04-18T22:16:23.948134Z","steps":["trace[293001385] 'agreement among raft nodes before linearized reading' (duration: 193.868982ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:23.948583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.188729ms","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":"warn","ts":"2026-04-18T22:16:23.948624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:23.568509Z","time spent":"378.845583ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:16:23.948636Z","caller":"traceutil/trace.go:171","msg":"trace[1520355317] 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:4727; }","duration":"293.24242ms","start":"2026-04-18T22:16:23.65538Z","end":"2026-04-18T22:16:23.948622Z","steps":["trace[1520355317] 'agreement among raft nodes before linearized reading' (duration: 292.221569ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:24.586377Z","caller":"traceutil/trace.go:171","msg":"trace[800707390] transaction","detail":"{read_only:false; response_revision:4739; number_of_response:1; }","duration":"296.441377ms","start":"2026-04-18T22:16:24.289916Z","end":"2026-04-18T22:16:24.586357Z","steps":["trace[800707390] 'process raft request' (duration: 296.307444ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:24.652201Z","caller":"traceutil/trace.go:171","msg":"trace[440077817] transaction","detail":"{read_only:false; response_revision:4740; number_of_response:1; }","duration":"239.808307ms","start":"2026-04-18T22:16:24.412373Z","end":"2026-04-18T22:16:24.652182Z","steps":["trace[440077817] 'process raft request' (duration: 239.595483ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:24.652287Z","caller":"traceutil/trace.go:171","msg":"trace[657575814] transaction","detail":"{read_only:false; response_revision:4741; number_of_response:1; }","duration":"238.402858ms","start":"2026-04-18T22:16:24.413843Z","end":"2026-04-18T22:16:24.652246Z","steps":["trace[657575814] 'process raft request' (duration: 238.278236ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:24.735396Z","caller":"traceutil/trace.go:171","msg":"trace[919620350] transaction","detail":"{read_only:false; response_revision:4742; number_of_response:1; }","duration":"112.535485ms","start":"2026-04-18T22:16:24.622836Z","end":"2026-04-18T22:16:24.735371Z","steps":["trace[919620350] 'process raft request' (duration: 112.388303ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:24.735572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.079746ms","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-04-18T22:16:24.73565Z","caller":"traceutil/trace.go:171","msg":"trace[393604147] 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:4742; }","duration":"150.159527ms","start":"2026-04-18T22:16:24.585469Z","end":"2026-04-18T22:16:24.735629Z","steps":["trace[393604147] 'agreement among raft nodes before linearized reading' (duration: 149.979564ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:24.73557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.821631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-7bcf85cfcc-rkl6x.18a7935796e5b89d\" ","response":"range_response_count:1 size:898"} {"level":"info","ts":"2026-04-18T22:16:24.735923Z","caller":"traceutil/trace.go:171","msg":"trace[231147200] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-7bcf85cfcc-rkl6x.18a7935796e5b89d; range_end:; response_count:1; response_revision:4742; }","duration":"156.023894ms","start":"2026-04-18T22:16:24.579691Z","end":"2026-04-18T22:16:24.735715Z","steps":["trace[231147200] 'agreement among raft nodes before linearized reading' (duration: 155.676427ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:37.502836Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10836959925205559076,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T22:16:37.984372Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.077474667s","expected-duration":"1s"} {"level":"info","ts":"2026-04-18T22:16:37.984799Z","caller":"traceutil/trace.go:171","msg":"trace[1323857860] linearizableReadLoop","detail":"{readStateIndex:5075; appliedIndex:5074; }","duration":"983.002363ms","start":"2026-04-18T22:16:37.001781Z","end":"2026-04-18T22:16:37.984784Z","steps":["trace[1323857860] 'read index received' (duration: 982.937342ms)","trace[1323857860] 'applied index is now lower than readState.Index' (duration: 64.441µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:16:37.984875Z","caller":"traceutil/trace.go:171","msg":"trace[728997816] transaction","detail":"{read_only:false; response_revision:4890; number_of_response:1; }","duration":"1.078027888s","start":"2026-04-18T22:16:36.906792Z","end":"2026-04-18T22:16:37.98482Z","steps":["trace[728997816] 'process raft request' (duration: 1.077869685s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:37.985016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"983.198487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"warn","ts":"2026-04-18T22:16:37.985034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:36.906778Z","time spent":"1.078177742s","remote":"127.0.0.1:60770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11655,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:16:37.985156Z","caller":"traceutil/trace.go:171","msg":"trace[1126260605] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4890; }","duration":"983.30975ms","start":"2026-04-18T22:16:37.001748Z","end":"2026-04-18T22:16:37.985057Z","steps":["trace[1126260605] 'agreement among raft nodes before linearized reading' (duration: 983.120026ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:37.985237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:37.001731Z","time spent":"983.498453ms","remote":"127.0.0.1:49472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3339,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"info","ts":"2026-04-18T22:16:38.085465Z","caller":"traceutil/trace.go:171","msg":"trace[1821278163] transaction","detail":"{read_only:false; response_revision:4891; number_of_response:1; }","duration":"133.123941ms","start":"2026-04-18T22:16:37.952313Z","end":"2026-04-18T22:16:38.085437Z","steps":["trace[1821278163] 'process raft request' (duration: 57.699141ms)","trace[1821278163] 'compare' (duration: 75.302778ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:16:38.085525Z","caller":"traceutil/trace.go:171","msg":"trace[531445403] linearizableReadLoop","detail":"{readStateIndex:5076; appliedIndex:5075; }","duration":"100.645055ms","start":"2026-04-18T22:16:37.98485Z","end":"2026-04-18T22:16:38.085495Z","steps":["trace[531445403] 'read index received' (duration: 25.202955ms)","trace[531445403] 'applied index is now lower than readState.Index' (duration: 75.43958ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:16:38.085709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.664118ms","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-04-18T22:16:38.08579Z","caller":"traceutil/trace.go:171","msg":"trace[830757333] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:4894; }","duration":"206.799361ms","start":"2026-04-18T22:16:37.878974Z","end":"2026-04-18T22:16:38.085774Z","steps":["trace[830757333] 'agreement among raft nodes before linearized reading' (duration: 206.606647ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:38.085736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.993374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:16:38.085979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.23483ms","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-04-18T22:16:38.085992Z","caller":"traceutil/trace.go:171","msg":"trace[1787700214] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:4894; }","duration":"277.291289ms","start":"2026-04-18T22:16:37.808691Z","end":"2026-04-18T22:16:38.085982Z","steps":["trace[1787700214] 'agreement among raft nodes before linearized reading' (duration: 276.946753ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:38.08602Z","caller":"traceutil/trace.go:171","msg":"trace[1261089457] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4894; }","duration":"357.306671ms","start":"2026-04-18T22:16:37.728701Z","end":"2026-04-18T22:16:38.086007Z","steps":["trace[1261089457] 'agreement among raft nodes before linearized reading' (duration: 357.066586ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:38.086056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:37.728686Z","time spent":"357.362473ms","remote":"127.0.0.1:60744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-04-18T22:16:38.308867Z","caller":"traceutil/trace.go:171","msg":"trace[146919502] transaction","detail":"{read_only:false; response_revision:4898; number_of_response:1; }","duration":"143.374905ms","start":"2026-04-18T22:16:38.165461Z","end":"2026-04-18T22:16:38.308836Z","steps":["trace[146919502] 'process raft request' (duration: 100.370079ms)","trace[146919502] 'compare' (duration: 42.825613ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:16:38.308939Z","caller":"traceutil/trace.go:171","msg":"trace[1317705525] transaction","detail":"{read_only:false; response_revision:4901; number_of_response:1; }","duration":"133.027617ms","start":"2026-04-18T22:16:38.175884Z","end":"2026-04-18T22:16:38.308911Z","steps":["trace[1317705525] 'process raft request' (duration: 132.969356ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:38.309126Z","caller":"traceutil/trace.go:171","msg":"trace[1798709596] transaction","detail":"{read_only:false; response_revision:4899; number_of_response:1; }","duration":"142.420398ms","start":"2026-04-18T22:16:38.166695Z","end":"2026-04-18T22:16:38.309115Z","steps":["trace[1798709596] 'process raft request' (duration: 142.079021ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:38.309346Z","caller":"traceutil/trace.go:171","msg":"trace[1339976727] transaction","detail":"{read_only:false; response_revision:4900; number_of_response:1; }","duration":"133.945184ms","start":"2026-04-18T22:16:38.175369Z","end":"2026-04-18T22:16:38.309314Z","steps":["trace[1339976727] 'process raft request' (duration: 133.451455ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:38.309434Z","caller":"traceutil/trace.go:171","msg":"trace[1602947104] linearizableReadLoop","detail":"{readStateIndex:5084; appliedIndex:5082; }","duration":"137.024564ms","start":"2026-04-18T22:16:38.172397Z","end":"2026-04-18T22:16:38.309422Z","steps":["trace[1602947104] 'read index received' (duration: 93.421327ms)","trace[1602947104] 'applied index is now lower than readState.Index' (duration: 43.601927ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:16:38.309648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.312692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-keystone.18a79357803b8a48\" ","response":"range_response_count:1 size:740"} {"level":"warn","ts":"2026-04-18T22:16:38.309631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.812205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9639"} {"level":"info","ts":"2026-04-18T22:16:38.30969Z","caller":"traceutil/trace.go:171","msg":"trace[496117430] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-keystone.18a79357803b8a48; range_end:; response_count:1; response_revision:4901; }","duration":"134.377873ms","start":"2026-04-18T22:16:38.1753Z","end":"2026-04-18T22:16:38.309677Z","steps":["trace[496117430] 'agreement among raft nodes before linearized reading' (duration: 134.22275ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:38.309703Z","caller":"traceutil/trace.go:171","msg":"trace[200453873] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4901; }","duration":"142.912026ms","start":"2026-04-18T22:16:38.166774Z","end":"2026-04-18T22:16:38.309686Z","steps":["trace[200453873] 'agreement among raft nodes before linearized reading' (duration: 142.710703ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:38.606452Z","caller":"traceutil/trace.go:171","msg":"trace[1118245391] linearizableReadLoop","detail":"{readStateIndex:5088; appliedIndex:5087; }","duration":"163.92604ms","start":"2026-04-18T22:16:38.442501Z","end":"2026-04-18T22:16:38.606427Z","steps":["trace[1118245391] 'read index received' (duration: 76.677473ms)","trace[1118245391] 'applied index is now lower than readState.Index' (duration: 87.247217ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:16:38.60659Z","caller":"traceutil/trace.go:171","msg":"trace[1073992448] transaction","detail":"{read_only:false; response_revision:4903; number_of_response:1; }","duration":"260.66509ms","start":"2026-04-18T22:16:38.34588Z","end":"2026-04-18T22:16:38.606545Z","steps":["trace[1073992448] 'process raft request' (duration: 173.388913ms)","trace[1073992448] 'compare' (duration: 86.971012ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:16:38.606805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.060923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:16:38.60686Z","caller":"traceutil/trace.go:171","msg":"trace[549261635] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:4903; }","duration":"164.387309ms","start":"2026-04-18T22:16:38.442456Z","end":"2026-04-18T22:16:38.606844Z","steps":["trace[549261635] 'agreement among raft nodes before linearized reading' (duration: 164.063383ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:39.012312Z","caller":"traceutil/trace.go:171","msg":"trace[292051970] transaction","detail":"{read_only:false; response_revision:4904; number_of_response:1; }","duration":"334.177203ms","start":"2026-04-18T22:16:38.678109Z","end":"2026-04-18T22:16:39.012286Z","steps":["trace[292051970] 'process raft request' (duration: 333.190294ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:39.012451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:38.678055Z","time spent":"334.329315ms","remote":"127.0.0.1:60668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":890,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T22:16:39.028679Z","caller":"traceutil/trace.go:171","msg":"trace[1609885975] linearizableReadLoop","detail":"{readStateIndex:5093; appliedIndex:5088; }","duration":"205.621921ms","start":"2026-04-18T22:16:38.823037Z","end":"2026-04-18T22:16:39.028659Z","steps":["trace[1609885975] 'read index received' (duration: 188.322179ms)","trace[1609885975] 'applied index is now lower than readState.Index' (duration: 17.298852ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:16:39.028723Z","caller":"traceutil/trace.go:171","msg":"trace[169623660] transaction","detail":"{read_only:false; response_revision:4906; number_of_response:1; }","duration":"282.467428ms","start":"2026-04-18T22:16:38.746243Z","end":"2026-04-18T22:16:39.028711Z","steps":["trace[169623660] 'process raft request' (duration: 282.338485ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:39.028764Z","caller":"traceutil/trace.go:171","msg":"trace[730120070] transaction","detail":"{read_only:false; response_revision:4908; number_of_response:1; }","duration":"256.621341ms","start":"2026-04-18T22:16:38.772126Z","end":"2026-04-18T22:16:39.028747Z","steps":["trace[730120070] 'process raft request' (duration: 256.506339ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:39.028801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.758643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:16:39.028825Z","caller":"traceutil/trace.go:171","msg":"trace[559193416] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4908; }","duration":"205.830305ms","start":"2026-04-18T22:16:38.822988Z","end":"2026-04-18T22:16:39.028819Z","steps":["trace[559193416] 'agreement among raft nodes before linearized reading' (duration: 205.776244ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:39.028669Z","caller":"traceutil/trace.go:171","msg":"trace[816344310] transaction","detail":"{read_only:false; response_revision:4905; number_of_response:1; }","duration":"308.487527ms","start":"2026-04-18T22:16:38.720165Z","end":"2026-04-18T22:16:39.028653Z","steps":["trace[816344310] 'process raft request' (duration: 308.307594ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:39.029046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:38.720147Z","time spent":"308.851635ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:16:39.028714Z","caller":"traceutil/trace.go:171","msg":"trace[382372584] transaction","detail":"{read_only:false; response_revision:4907; number_of_response:1; }","duration":"266.293627ms","start":"2026-04-18T22:16:38.762397Z","end":"2026-04-18T22:16:39.028691Z","steps":["trace[382372584] 'process raft request' (duration: 266.211126ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:39.925972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.558726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:16:39.926062Z","caller":"traceutil/trace.go:171","msg":"trace[2067579505] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4911; }","duration":"102.697508ms","start":"2026-04-18T22:16:39.823339Z","end":"2026-04-18T22:16:39.926037Z","steps":["trace[2067579505] 'range keys from in-memory index tree' (duration: 102.461753ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:15.378139Z","caller":"traceutil/trace.go:171","msg":"trace[1292282965] transaction","detail":"{read_only:false; response_revision:5232; number_of_response:1; }","duration":"163.886877ms","start":"2026-04-18T22:17:15.214225Z","end":"2026-04-18T22:17:15.378112Z","steps":["trace[1292282965] 'process raft request' (duration: 124.926101ms)","trace[1292282965] 'compare' (duration: 38.783343ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:17:15.378389Z","caller":"traceutil/trace.go:171","msg":"trace[1165043590] transaction","detail":"{read_only:false; response_revision:5234; number_of_response:1; }","duration":"114.017679ms","start":"2026-04-18T22:17:15.264344Z","end":"2026-04-18T22:17:15.378361Z","steps":["trace[1165043590] 'process raft request' (duration: 113.929477ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:15.378551Z","caller":"traceutil/trace.go:171","msg":"trace[1750904993] transaction","detail":"{read_only:false; response_revision:5233; number_of_response:1; }","duration":"162.225288ms","start":"2026-04-18T22:17:15.216207Z","end":"2026-04-18T22:17:15.378432Z","steps":["trace[1750904993] 'process raft request' (duration: 161.859381ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:18.418302Z","caller":"traceutil/trace.go:171","msg":"trace[619591632] transaction","detail":"{read_only:false; response_revision:5244; number_of_response:1; }","duration":"110.22927ms","start":"2026-04-18T22:17:18.308042Z","end":"2026-04-18T22:17:18.418272Z","steps":["trace[619591632] 'process raft request' (duration: 110.102048ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:30.733187Z","caller":"traceutil/trace.go:171","msg":"trace[1770361600] transaction","detail":"{read_only:false; response_revision:5339; number_of_response:1; }","duration":"122.539544ms","start":"2026-04-18T22:17:30.610627Z","end":"2026-04-18T22:17:30.733167Z","steps":["trace[1770361600] 'process raft request' (duration: 122.132157ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:35.651836Z","caller":"traceutil/trace.go:171","msg":"trace[68717593] transaction","detail":"{read_only:false; response_revision:5366; number_of_response:1; }","duration":"267.60267ms","start":"2026-04-18T22:17:35.384207Z","end":"2026-04-18T22:17:35.65181Z","steps":["trace[68717593] 'process raft request' (duration: 267.420247ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:36.31388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.927775ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:36.314587Z","caller":"traceutil/trace.go:171","msg":"trace[604160150] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5366; }","duration":"204.647267ms","start":"2026-04-18T22:17:36.109912Z","end":"2026-04-18T22:17:36.314559Z","steps":["trace[604160150] 'range keys from in-memory index tree' (duration: 203.911855ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:36.3147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.977558ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T22:17:36.314871Z","caller":"traceutil/trace.go:171","msg":"trace[1492390293] transaction","detail":"{read_only:false; response_revision:5367; number_of_response:1; }","duration":"874.831947ms","start":"2026-04-18T22:17:35.440025Z","end":"2026-04-18T22:17:36.314856Z","steps":["trace[1492390293] 'process raft request' (duration: 350.581524ms)","trace[1492390293] 'compare' (duration: 522.83015ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:17:36.314895Z","caller":"traceutil/trace.go:171","msg":"trace[1549715367] transaction","detail":"{read_only:false; response_revision:5368; number_of_response:1; }","duration":"873.494623ms","start":"2026-04-18T22:17:35.441388Z","end":"2026-04-18T22:17:36.314882Z","steps":["trace[1549715367] 'process raft request' (duration: 873.379701ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:36.314956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:35.441382Z","time spent":"873.542114ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:17:36.314958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:35.440008Z","time spent":"874.904628ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:17:36.315083Z","caller":"traceutil/trace.go:171","msg":"trace[549338975] transaction","detail":"{read_only:false; response_revision:5369; number_of_response:1; }","duration":"873.635736ms","start":"2026-04-18T22:17:35.441425Z","end":"2026-04-18T22:17:36.31506Z","steps":["trace[549338975] 'process raft request' (duration: 873.425813ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:36.3152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:35.441419Z","time spent":"873.716778ms","remote":"127.0.0.1:60868","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-04-18T22:17:36.315329Z","caller":"traceutil/trace.go:171","msg":"trace[346259948] transaction","detail":"{read_only:false; response_revision:5370; number_of_response:1; }","duration":"731.795468ms","start":"2026-04-18T22:17:35.583523Z","end":"2026-04-18T22:17:36.315318Z","steps":["trace[346259948] 'process raft request' (duration: 731.470831ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:36.31535Z","caller":"traceutil/trace.go:171","msg":"trace[841603750] linearizableReadLoop","detail":"{readStateIndex:5569; appliedIndex:5564; }","duration":"720.389894ms","start":"2026-04-18T22:17:35.594949Z","end":"2026-04-18T22:17:36.315339Z","steps":["trace[841603750] 'read index received' (duration: 56.748251ms)","trace[841603750] 'applied index is now lower than readState.Index' (duration: 663.640773ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:17:36.315403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:35.583501Z","time spent":"731.867538ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:17:36.315439Z","caller":"traceutil/trace.go:171","msg":"trace[710109724] transaction","detail":"{read_only:false; response_revision:5371; number_of_response:1; }","duration":"230.379652ms","start":"2026-04-18T22:17:36.085051Z","end":"2026-04-18T22:17:36.31543Z","steps":["trace[710109724] 'process raft request' (duration: 230.114347ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:36.315638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"720.689779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-18T22:17:36.315668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.431298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:36.315676Z","caller":"traceutil/trace.go:171","msg":"trace[1083454918] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:5371; }","duration":"720.76133ms","start":"2026-04-18T22:17:35.594906Z","end":"2026-04-18T22:17:36.315668Z","steps":["trace[1083454918] 'agreement among raft nodes before linearized reading' (duration: 720.692649ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:36.315705Z","caller":"traceutil/trace.go:171","msg":"trace[1168397548] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5371; }","duration":"491.51236ms","start":"2026-04-18T22:17:35.824181Z","end":"2026-04-18T22:17:36.315693Z","steps":["trace[1168397548] 'agreement among raft nodes before linearized reading' (duration: 491.456609ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:36.315708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:35.594891Z","time spent":"720.808841ms","remote":"127.0.0.1:32780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-04-18T22:17:36.31572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.794007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:17:36.315735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:35.824161Z","time spent":"491.56805ms","remote":"127.0.0.1:60602","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-04-18T22:17:36.315755Z","caller":"traceutil/trace.go:171","msg":"trace[1149699422] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:5371; }","duration":"160.870439ms","start":"2026-04-18T22:17:36.154873Z","end":"2026-04-18T22:17:36.315743Z","steps":["trace[1149699422] 'agreement among raft nodes before linearized reading' (duration: 160.811598ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:36.315878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.015679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-18T22:17:36.315913Z","caller":"traceutil/trace.go:171","msg":"trace[928268142] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:5371; }","duration":"229.052009ms","start":"2026-04-18T22:17:36.086853Z","end":"2026-04-18T22:17:36.315905Z","steps":["trace[928268142] 'agreement among raft nodes before linearized reading' (duration: 228.991188ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:36.316033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.501827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-04-18T22:17:36.316076Z","caller":"traceutil/trace.go:171","msg":"trace[1746418649] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:5371; }","duration":"469.541478ms","start":"2026-04-18T22:17:35.846522Z","end":"2026-04-18T22:17:36.316063Z","steps":["trace[1746418649] 'agreement among raft nodes before linearized reading' (duration: 469.422146ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:36.316104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:35.846468Z","time spent":"469.629609ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":582,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-04-18T22:17:36.919369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.024331ms","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-04-18T22:17:36.919526Z","caller":"traceutil/trace.go:171","msg":"trace[601924913] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5373; }","duration":"122.245624ms","start":"2026-04-18T22:17:36.797262Z","end":"2026-04-18T22:17:36.919508Z","steps":["trace[601924913] 'range keys from in-memory index tree' (duration: 121.833178ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:36.919919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.349492ms","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-04-18T22:17:36.920397Z","caller":"traceutil/trace.go:171","msg":"trace[1474868026] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5373; }","duration":"146.870232ms","start":"2026-04-18T22:17:36.773512Z","end":"2026-04-18T22:17:36.920383Z","steps":["trace[1474868026] 'range keys from in-memory index tree' (duration: 146.168699ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:37.193989Z","caller":"traceutil/trace.go:171","msg":"trace[135687139] transaction","detail":"{read_only:false; response_revision:5377; number_of_response:1; }","duration":"268.706164ms","start":"2026-04-18T22:17:36.925257Z","end":"2026-04-18T22:17:37.193963Z","steps":["trace[135687139] 'process raft request' (duration: 268.659923ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:37.193995Z","caller":"traceutil/trace.go:171","msg":"trace[2141098436] transaction","detail":"{read_only:false; response_revision:5375; number_of_response:1; }","duration":"269.358765ms","start":"2026-04-18T22:17:36.924603Z","end":"2026-04-18T22:17:37.193962Z","steps":["trace[2141098436] 'process raft request' (duration: 269.0742ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:37.194047Z","caller":"traceutil/trace.go:171","msg":"trace[635394763] transaction","detail":"{read_only:false; response_revision:5376; number_of_response:1; }","duration":"268.871187ms","start":"2026-04-18T22:17:36.92515Z","end":"2026-04-18T22:17:37.194021Z","steps":["trace[635394763] 'process raft request' (duration: 268.716204ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:37.507619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.197316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:37.507696Z","caller":"traceutil/trace.go:171","msg":"trace[759761718] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:5377; }","duration":"111.314997ms","start":"2026-04-18T22:17:37.396361Z","end":"2026-04-18T22:17:37.507676Z","steps":["trace[759761718] 'count revisions from in-memory index tree' (duration: 111.106834ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:37.507941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.597381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-04-18T22:17:37.508023Z","caller":"traceutil/trace.go:171","msg":"trace[403476245] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5377; }","duration":"210.715753ms","start":"2026-04-18T22:17:37.297284Z","end":"2026-04-18T22:17:37.508Z","steps":["trace[403476245] 'range keys from in-memory index tree' (duration: 210.431528ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:37.901404Z","caller":"traceutil/trace.go:171","msg":"trace[276729722] transaction","detail":"{read_only:false; response_revision:5378; number_of_response:1; }","duration":"245.434989ms","start":"2026-04-18T22:17:37.655956Z","end":"2026-04-18T22:17:37.901391Z","steps":["trace[276729722] 'process raft request' (duration: 245.271007ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:37.901373Z","caller":"traceutil/trace.go:171","msg":"trace[538841942] linearizableReadLoop","detail":"{readStateIndex:5577; appliedIndex:5576; }","duration":"157.452996ms","start":"2026-04-18T22:17:37.743899Z","end":"2026-04-18T22:17:37.901352Z","steps":["trace[538841942] 'read index received' (duration: 157.279783ms)","trace[538841942] 'applied index is now lower than readState.Index' (duration: 172.473µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:17:37.901483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.572007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-18T22:17:37.9016Z","caller":"traceutil/trace.go:171","msg":"trace[1834947440] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:5378; }","duration":"157.69788ms","start":"2026-04-18T22:17:37.743855Z","end":"2026-04-18T22:17:37.901553Z","steps":["trace[1834947440] 'agreement among raft nodes before linearized reading' (duration: 157.576178ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:38.665271Z","caller":"traceutil/trace.go:171","msg":"trace[675059558] transaction","detail":"{read_only:false; response_revision:5379; number_of_response:1; }","duration":"344.227523ms","start":"2026-04-18T22:17:38.321018Z","end":"2026-04-18T22:17:38.665246Z","steps":["trace[675059558] 'process raft request' (duration: 344.05475ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:38.665436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:38.320994Z","time spent":"344.359926ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:17:40.500276Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.198654132s","expected-duration":"1s"} {"level":"info","ts":"2026-04-18T22:17:40.500695Z","caller":"traceutil/trace.go:171","msg":"trace[1616909010] transaction","detail":"{read_only:false; response_revision:5380; number_of_response:1; }","duration":"2.179565002s","start":"2026-04-18T22:17:38.32111Z","end":"2026-04-18T22:17:40.500675Z","steps":["trace[1616909010] 'process raft request' (duration: 2.179326847s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:40.500843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:38.321084Z","time spent":"2.179675294s","remote":"127.0.0.1:60868","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-04-18T22:17:40.501035Z","caller":"traceutil/trace.go:171","msg":"trace[1818066596] linearizableReadLoop","detail":"{readStateIndex:5580; appliedIndex:5577; }","duration":"2.028177714s","start":"2026-04-18T22:17:38.472828Z","end":"2026-04-18T22:17:40.501005Z","steps":["trace[1818066596] 'read index received' (duration: 192.389337ms)","trace[1818066596] 'applied index is now lower than readState.Index' (duration: 1.835785617s)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:17:40.501086Z","caller":"traceutil/trace.go:171","msg":"trace[40501862] transaction","detail":"{read_only:false; response_revision:5381; number_of_response:1; }","duration":"2.17942735s","start":"2026-04-18T22:17:38.32165Z","end":"2026-04-18T22:17:40.501077Z","steps":["trace[40501862] 'process raft request' (duration: 2.178988293s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:40.501138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:38.321634Z","time spent":"2.179476291s","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:17:40.501332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.028458059s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:40.501389Z","caller":"traceutil/trace.go:171","msg":"trace[1129064951] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5381; }","duration":"2.028591041s","start":"2026-04-18T22:17:38.472786Z","end":"2026-04-18T22:17:40.501377Z","steps":["trace[1129064951] 'agreement among raft nodes before linearized reading' (duration: 2.028321787s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:40.501491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:38.472771Z","time spent":"2.028707413s","remote":"127.0.0.1:60838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" "} {"level":"warn","ts":"2026-04-18T22:17:40.513266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.040256607s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:40.513302Z","caller":"traceutil/trace.go:171","msg":"trace[1372402074] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5383; }","duration":"2.040307398s","start":"2026-04-18T22:17:38.472985Z","end":"2026-04-18T22:17:40.513293Z","steps":["trace[1372402074] 'agreement among raft nodes before linearized reading' (duration: 2.040228546s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:40.513324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:38.47298Z","time spent":"2.040338638s","remote":"127.0.0.1:60838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/keystone-db-sync\" "} {"level":"warn","ts":"2026-04-18T22:17:40.513495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.314596479s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-18T22:17:40.51364Z","caller":"traceutil/trace.go:171","msg":"trace[1672121278] transaction","detail":"{read_only:false; response_revision:5383; number_of_response:1; }","duration":"604.214675ms","start":"2026-04-18T22:17:39.909401Z","end":"2026-04-18T22:17:40.513616Z","steps":["trace[1672121278] 'process raft request' (duration: 603.770608ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:40.51358Z","caller":"traceutil/trace.go:171","msg":"trace[1014489205] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5383; }","duration":"1.314762382s","start":"2026-04-18T22:17:39.198797Z","end":"2026-04-18T22:17:40.513559Z","steps":["trace[1014489205] 'agreement among raft nodes before linearized reading' (duration: 1.314444207s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:40.513756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:39.198791Z","time spent":"1.314950625s","remote":"127.0.0.1:60868","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":"warn","ts":"2026-04-18T22:17:40.51376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:39.909375Z","time spent":"604.320056ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:17:40.514052Z","caller":"traceutil/trace.go:171","msg":"trace[1132840390] transaction","detail":"{read_only:false; response_revision:5382; number_of_response:1; }","duration":"1.576832997s","start":"2026-04-18T22:17:38.936789Z","end":"2026-04-18T22:17:40.513622Z","steps":["trace[1132840390] 'process raft request' (duration: 1.576285938s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:40.514391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.315685907s","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-04-18T22:17:40.514433Z","caller":"traceutil/trace.go:171","msg":"trace[1004778845] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5383; }","duration":"1.315722408s","start":"2026-04-18T22:17:39.198696Z","end":"2026-04-18T22:17:40.514419Z","steps":["trace[1004778845] 'agreement among raft nodes before linearized reading' (duration: 1.314818713s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:40.514454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:39.19859Z","time spent":"1.31585903s","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-18T22:17:40.514649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.412313652s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-04-18T22:17:40.514669Z","caller":"traceutil/trace.go:171","msg":"trace[2028335936] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5383; }","duration":"1.412360673s","start":"2026-04-18T22:17:39.102303Z","end":"2026-04-18T22:17:40.514664Z","steps":["trace[2028335936] 'agreement among raft nodes before linearized reading' (duration: 1.411225103s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:40.514683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:39.102288Z","time spent":"1.412391323s","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":552,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"warn","ts":"2026-04-18T22:17:40.514765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.943042911s","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-04-18T22:17:40.514785Z","caller":"traceutil/trace.go:171","msg":"trace[991609707] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:5383; }","duration":"1.943092812s","start":"2026-04-18T22:17:38.571687Z","end":"2026-04-18T22:17:40.51478Z","steps":["trace[991609707] 'agreement among raft nodes before linearized reading' (duration: 1.941852821s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:40.514799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:38.57167Z","time spent":"1.943124582s","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"warn","ts":"2026-04-18T22:17:40.514934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.973383731s","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-04-18T22:17:40.514956Z","caller":"traceutil/trace.go:171","msg":"trace[1609322315] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5383; }","duration":"1.973442683s","start":"2026-04-18T22:17:38.541507Z","end":"2026-04-18T22:17:40.51495Z","steps":["trace[1609322315] 'agreement among raft nodes before linearized reading' (duration: 1.972041259s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:40.51497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:38.541488Z","time spent":"1.973477893s","remote":"127.0.0.1:60868","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-04-18T22:17:40.515189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.787728856s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-18T22:17:40.515251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.691960295s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:40.515282Z","caller":"traceutil/trace.go:171","msg":"trace[959355323] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5383; }","duration":"1.692031056s","start":"2026-04-18T22:17:38.823245Z","end":"2026-04-18T22:17:40.515277Z","steps":["trace[959355323] 'agreement among raft nodes before linearized reading' (duration: 1.690333087s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:40.515297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:38.823225Z","time spent":"1.692068306s","remote":"127.0.0.1:60602","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-04-18T22:17:40.515422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.524493395s","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-04-18T22:17:40.515439Z","caller":"traceutil/trace.go:171","msg":"trace[1750488876] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5383; }","duration":"1.524537637s","start":"2026-04-18T22:17:38.990896Z","end":"2026-04-18T22:17:40.515434Z","steps":["trace[1750488876] 'agreement among raft nodes before linearized reading' (duration: 1.522676175s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:40.515452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:38.990884Z","time spent":"1.524565027s","remote":"127.0.0.1:60868","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-04-18T22:17:40.515555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.643943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-18T22:17:40.515576Z","caller":"traceutil/trace.go:171","msg":"trace[103185675] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:5383; }","duration":"436.729574ms","start":"2026-04-18T22:17:40.078841Z","end":"2026-04-18T22:17:40.51557Z","steps":["trace[103185675] 'agreement among raft nodes before linearized reading' (duration: 434.759791ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:40.515592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:40.078818Z","time spent":"436.768744ms","remote":"127.0.0.1:47044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":31,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"warn","ts":"2026-04-18T22:17:40.515712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.184315841s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.246\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-18T22:17:40.515731Z","caller":"traceutil/trace.go:171","msg":"trace[371254875] range","detail":"{range_begin:/registry/masterleases/199.204.45.246; range_end:; response_count:1; response_revision:5383; }","duration":"1.184360052s","start":"2026-04-18T22:17:39.331363Z","end":"2026-04-18T22:17:40.515723Z","steps":["trace[371254875] 'agreement among raft nodes before linearized reading' (duration: 1.182233277s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:40.515745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:39.331348Z","time spent":"1.184392653s","remote":"127.0.0.1:60632","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.246\" "} {"level":"warn","ts":"2026-04-18T22:17:40.515897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.31701555s","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-04-18T22:17:40.515918Z","caller":"traceutil/trace.go:171","msg":"trace[316322035] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5383; }","duration":"1.317062691s","start":"2026-04-18T22:17:39.19885Z","end":"2026-04-18T22:17:40.515913Z","steps":["trace[316322035] 'agreement among raft nodes before linearized reading' (duration: 1.314773912s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:40.515933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:39.198837Z","time spent":"1.317091561s","remote":"127.0.0.1:60868","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-04-18T22:17:40.515218Z","caller":"traceutil/trace.go:171","msg":"trace[1178185034] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:5383; }","duration":"1.787922049s","start":"2026-04-18T22:17:38.727287Z","end":"2026-04-18T22:17:40.515209Z","steps":["trace[1178185034] 'agreement among raft nodes before linearized reading' (duration: 1.786258931s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:40.517517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:38.727268Z","time spent":"1.790240669s","remote":"127.0.0.1:32878","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":10,"response size":30,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "} {"level":"warn","ts":"2026-04-18T22:17:40.517911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:38.936769Z","time spent":"1.578281592s","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:17:40.742333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.323351ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T22:17:40.742552Z","caller":"traceutil/trace.go:171","msg":"trace[1053313687] transaction","detail":"{read_only:false; response_revision:5386; number_of_response:1; }","duration":"222.243857ms","start":"2026-04-18T22:17:40.520294Z","end":"2026-04-18T22:17:40.742538Z","steps":["trace[1053313687] 'process raft request' (duration: 222.173006ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:40.742868Z","caller":"traceutil/trace.go:171","msg":"trace[2087536714] transaction","detail":"{read_only:false; response_revision:5384; number_of_response:1; }","duration":"224.125428ms","start":"2026-04-18T22:17:40.518726Z","end":"2026-04-18T22:17:40.742852Z","steps":["trace[2087536714] 'process raft request' (duration: 70.196687ms)","trace[2087536714] 'compare' (duration: 153.054027ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:17:40.742893Z","caller":"traceutil/trace.go:171","msg":"trace[577898473] transaction","detail":"{read_only:false; response_revision:5385; number_of_response:1; }","duration":"223.158012ms","start":"2026-04-18T22:17:40.519692Z","end":"2026-04-18T22:17:40.74285Z","steps":["trace[577898473] 'process raft request' (duration: 222.715485ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:40.743019Z","caller":"traceutil/trace.go:171","msg":"trace[730665536] transaction","detail":"{read_only:false; response_revision:5388; number_of_response:1; }","duration":"221.726889ms","start":"2026-04-18T22:17:40.521263Z","end":"2026-04-18T22:17:40.74299Z","steps":["trace[730665536] 'process raft request' (duration: 221.591026ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:40.74303Z","caller":"traceutil/trace.go:171","msg":"trace[708445795] transaction","detail":"{read_only:false; response_revision:5387; number_of_response:1; }","duration":"222.703574ms","start":"2026-04-18T22:17:40.520298Z","end":"2026-04-18T22:17:40.743002Z","steps":["trace[708445795] 'process raft request' (duration: 222.203806ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:40.743141Z","caller":"traceutil/trace.go:171","msg":"trace[843879383] transaction","detail":"{read_only:false; response_revision:5389; number_of_response:1; }","duration":"221.80997ms","start":"2026-04-18T22:17:40.521319Z","end":"2026-04-18T22:17:40.743129Z","steps":["trace[843879383] 'process raft request' (duration: 221.621567ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:40.743232Z","caller":"traceutil/trace.go:171","msg":"trace[415793899] linearizableReadLoop","detail":"{readStateIndex:5589; appliedIndex:5583; }","duration":"218.981452ms","start":"2026-04-18T22:17:40.524239Z","end":"2026-04-18T22:17:40.74322Z","steps":["trace[415793899] 'read index received' (duration: 21.836937ms)","trace[415793899] 'applied index is now lower than readState.Index' (duration: 197.143235ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:17:40.743332Z","caller":"traceutil/trace.go:171","msg":"trace[458594066] transaction","detail":"{read_only:false; response_revision:5390; number_of_response:1; }","duration":"196.369793ms","start":"2026-04-18T22:17:40.546947Z","end":"2026-04-18T22:17:40.743317Z","steps":["trace[458594066] 'process raft request' (duration: 196.126739ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:40.74334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.110164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:40.743382Z","caller":"traceutil/trace.go:171","msg":"trace[1199993782] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5391; }","duration":"219.178606ms","start":"2026-04-18T22:17:40.52419Z","end":"2026-04-18T22:17:40.743369Z","steps":["trace[1199993782] 'agreement among raft nodes before linearized reading' (duration: 219.075004ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:18:06.556256Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2921} {"level":"info","ts":"2026-04-18T22:18:06.730675Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2921,"took":"173.012506ms","hash":973646867,"current-db-size-bytes":54112256,"current-db-size":"54 MB","current-db-size-in-use-bytes":29155328,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-18T22:18:06.730728Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":973646867,"revision":2921,"compact-revision":-1} {"level":"warn","ts":"2026-04-18T22:18:35.325497Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10836959925205561248,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T22:18:35.800169Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.027953273s","expected-duration":"1s"} {"level":"info","ts":"2026-04-18T22:18:35.804148Z","caller":"traceutil/trace.go:171","msg":"trace[757461018] transaction","detail":"{read_only:false; response_revision:5765; number_of_response:1; }","duration":"1.023931701s","start":"2026-04-18T22:18:34.780192Z","end":"2026-04-18T22:18:35.804124Z","steps":["trace[757461018] 'process raft request' (duration: 1.023839659s)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:18:35.804201Z","caller":"traceutil/trace.go:171","msg":"trace[1754836848] transaction","detail":"{read_only:false; response_revision:5764; number_of_response:1; }","duration":"1.027034928s","start":"2026-04-18T22:18:34.777128Z","end":"2026-04-18T22:18:35.804163Z","steps":["trace[1754836848] 'process raft request' (duration: 1.026747774s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:35.80435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:34.780178Z","time spent":"1.024060992s","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:18:35.804558Z","caller":"traceutil/trace.go:171","msg":"trace[718543835] transaction","detail":"{read_only:false; response_revision:5766; number_of_response:1; }","duration":"1.024237615s","start":"2026-04-18T22:18:34.780296Z","end":"2026-04-18T22:18:35.804533Z","steps":["trace[718543835] 'process raft request' (duration: 1.023794158s)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:18:35.804619Z","caller":"traceutil/trace.go:171","msg":"trace[1724372928] linearizableReadLoop","detail":"{readStateIndex:5980; appliedIndex:5974; }","duration":"979.82102ms","start":"2026-04-18T22:18:34.824775Z","end":"2026-04-18T22:18:35.804596Z","steps":["trace[1724372928] 'read index received' (duration: 975.675756ms)","trace[1724372928] 'applied index is now lower than readState.Index' (duration: 4.144144ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:18:35.804814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"980.046175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:18:35.804807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:34.780269Z","time spent":"1.024386297s","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:18:35.804913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"800.710169ms","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-04-18T22:18:35.80496Z","caller":"traceutil/trace.go:171","msg":"trace[2137661208] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5768; }","duration":"800.813791ms","start":"2026-04-18T22:18:35.004135Z","end":"2026-04-18T22:18:35.804948Z","steps":["trace[2137661208] 'agreement among raft nodes before linearized reading' (duration: 800.631637ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:35.805002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:35.00412Z","time spent":"800.874142ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-18T22:18:35.804919Z","caller":"traceutil/trace.go:171","msg":"trace[276273832] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5768; }","duration":"980.136896ms","start":"2026-04-18T22:18:34.824745Z","end":"2026-04-18T22:18:35.804882Z","steps":["trace[276273832] 'agreement among raft nodes before linearized reading' (duration: 979.972553ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:35.805216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"732.179584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-18T22:18:35.805269Z","caller":"traceutil/trace.go:171","msg":"trace[1206452270] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:5768; }","duration":"732.295077ms","start":"2026-04-18T22:18:35.072961Z","end":"2026-04-18T22:18:35.805256Z","steps":["trace[1206452270] 'agreement among raft nodes before linearized reading' (duration: 732.182825ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:35.805326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:35.072949Z","time spent":"732.365468ms","remote":"127.0.0.1:49472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":30,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true "} {"level":"warn","ts":"2026-04-18T22:18:35.805261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:34.824664Z","time spent":"980.578162ms","remote":"127.0.0.1:60602","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-04-18T22:18:35.804807Z","caller":"traceutil/trace.go:171","msg":"trace[886756651] transaction","detail":"{read_only:false; response_revision:5768; number_of_response:1; }","duration":"585.160939ms","start":"2026-04-18T22:18:35.219484Z","end":"2026-04-18T22:18:35.804645Z","steps":["trace[886756651] 'process raft request' (duration: 585.047948ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:35.805792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:35.219459Z","time spent":"586.228826ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:18:35.805569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"798.962342ms","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-04-18T22:18:35.806294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:34.777098Z","time spent":"1.027234131s","remote":"127.0.0.1:60868","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-04-18T22:18:35.806352Z","caller":"traceutil/trace.go:171","msg":"trace[2084602526] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5768; }","duration":"799.771415ms","start":"2026-04-18T22:18:35.00656Z","end":"2026-04-18T22:18:35.806331Z","steps":["trace[2084602526] 'agreement among raft nodes before linearized reading' (duration: 798.630548ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:35.806502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"795.816234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-18T22:18:35.80654Z","caller":"traceutil/trace.go:171","msg":"trace[1673281462] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5768; }","duration":"795.875625ms","start":"2026-04-18T22:18:35.010654Z","end":"2026-04-18T22:18:35.806529Z","steps":["trace[1673281462] 'agreement among raft nodes before linearized reading' (duration: 794.470704ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:35.806576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:35.010644Z","time spent":"795.925525ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-18T22:18:35.806676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"797.384118ms","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-04-18T22:18:35.807097Z","caller":"traceutil/trace.go:171","msg":"trace[1812878507] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5768; }","duration":"797.826704ms","start":"2026-04-18T22:18:35.009263Z","end":"2026-04-18T22:18:35.80709Z","steps":["trace[1812878507] 'agreement among raft nodes before linearized reading' (duration: 795.802894ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:35.807146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:35.009254Z","time spent":"797.884275ms","remote":"127.0.0.1:60868","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-04-18T22:18:35.804626Z","caller":"traceutil/trace.go:171","msg":"trace[962351600] transaction","detail":"{read_only:false; response_revision:5767; number_of_response:1; }","duration":"876.491827ms","start":"2026-04-18T22:18:34.928122Z","end":"2026-04-18T22:18:35.804614Z","steps":["trace[962351600] 'process raft request' (duration: 876.258213ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:35.806917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"796.133098ms","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-04-18T22:18:35.807379Z","caller":"traceutil/trace.go:171","msg":"trace[416156871] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5768; }","duration":"796.614855ms","start":"2026-04-18T22:18:35.010758Z","end":"2026-04-18T22:18:35.807373Z","steps":["trace[416156871] 'agreement among raft nodes before linearized reading' (duration: 794.295531ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:35.80741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:35.010754Z","time spent":"796.650027ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-18T22:18:35.80759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:34.928088Z","time spent":"879.155747ms","remote":"127.0.0.1:60868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:18:35.806434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:35.006549Z","time spent":"799.869156ms","remote":"127.0.0.1:60868","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-04-18T22:18:37.970011Z","caller":"traceutil/trace.go:171","msg":"trace[1468388801] transaction","detail":"{read_only:false; response_revision:5777; number_of_response:1; }","duration":"157.891804ms","start":"2026-04-18T22:18:37.812091Z","end":"2026-04-18T22:18:37.969983Z","steps":["trace[1468388801] 'process raft request' (duration: 119.070889ms)","trace[1468388801] 'compare' (duration: 38.606022ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:18:37.970249Z","caller":"traceutil/trace.go:171","msg":"trace[1175899962] linearizableReadLoop","detail":"{readStateIndex:5991; appliedIndex:5987; }","duration":"152.762066ms","start":"2026-04-18T22:18:37.81746Z","end":"2026-04-18T22:18:37.970222Z","steps":["trace[1175899962] 'read index received' (duration: 17.089923ms)","trace[1175899962] 'applied index is now lower than readState.Index' (duration: 135.671263ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:18:37.970318Z","caller":"traceutil/trace.go:171","msg":"trace[170254804] transaction","detail":"{read_only:false; response_revision:5779; number_of_response:1; }","duration":"155.834594ms","start":"2026-04-18T22:18:37.814459Z","end":"2026-04-18T22:18:37.970294Z","steps":["trace[170254804] 'process raft request' (duration: 155.65269ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:37.970517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.687105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-18T22:18:37.970521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.019311ms","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-04-18T22:18:37.97095Z","caller":"traceutil/trace.go:171","msg":"trace[938934101] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5779; }","duration":"153.497407ms","start":"2026-04-18T22:18:37.817406Z","end":"2026-04-18T22:18:37.970903Z","steps":["trace[938934101] 'agreement among raft nodes before linearized reading' (duration: 153.01135ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:18:37.970561Z","caller":"traceutil/trace.go:171","msg":"trace[975514304] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5779; }","duration":"152.795077ms","start":"2026-04-18T22:18:37.817754Z","end":"2026-04-18T22:18:37.970549Z","steps":["trace[975514304] 'agreement among raft nodes before linearized reading' (duration: 152.648295ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:18:37.970382Z","caller":"traceutil/trace.go:171","msg":"trace[1638014313] transaction","detail":"{read_only:false; response_revision:5778; number_of_response:1; }","duration":"157.465439ms","start":"2026-04-18T22:18:37.812894Z","end":"2026-04-18T22:18:37.97036Z","steps":["trace[1638014313] 'process raft request' (duration: 157.046682ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:37.970575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.063356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-18T22:18:37.97122Z","caller":"traceutil/trace.go:171","msg":"trace[424174336] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5779; }","duration":"152.735596ms","start":"2026-04-18T22:18:37.818471Z","end":"2026-04-18T22:18:37.971207Z","steps":["trace[424174336] 'agreement among raft nodes before linearized reading' (duration: 151.989625ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:37.970636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.497793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-18T22:18:37.971354Z","caller":"traceutil/trace.go:171","msg":"trace[406208505] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5779; }","duration":"153.250384ms","start":"2026-04-18T22:18:37.818084Z","end":"2026-04-18T22:18:37.971335Z","steps":["trace[406208505] 'agreement among raft nodes before linearized reading' (duration: 152.496142ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:37.971616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.129381ms","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-04-18T22:18:37.971687Z","caller":"traceutil/trace.go:171","msg":"trace[129867548] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5779; }","duration":"152.290179ms","start":"2026-04-18T22:18:37.819377Z","end":"2026-04-18T22:18:37.971668Z","steps":["trace[129867548] 'agreement among raft nodes before linearized reading' (duration: 151.06491ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:18:38.076276Z","caller":"traceutil/trace.go:171","msg":"trace[157360570] transaction","detail":"{read_only:false; response_revision:5781; number_of_response:1; }","duration":"100.545263ms","start":"2026-04-18T22:18:37.97571Z","end":"2026-04-18T22:18:38.076255Z","steps":["trace[157360570] 'process raft request' (duration: 100.215378ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:18:38.076541Z","caller":"traceutil/trace.go:171","msg":"trace[1363223551] transaction","detail":"{read_only:false; response_revision:5782; number_of_response:1; }","duration":"100.759876ms","start":"2026-04-18T22:18:37.975758Z","end":"2026-04-18T22:18:38.076518Z","steps":["trace[1363223551] 'process raft request' (duration: 100.459222ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:18:38.077127Z","caller":"traceutil/trace.go:171","msg":"trace[1438756464] transaction","detail":"{read_only:false; response_revision:5784; number_of_response:1; }","duration":"101.03045ms","start":"2026-04-18T22:18:37.976085Z","end":"2026-04-18T22:18:38.077115Z","steps":["trace[1438756464] 'process raft request' (duration: 100.931309ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:18:38.077139Z","caller":"traceutil/trace.go:171","msg":"trace[383242227] transaction","detail":"{read_only:false; response_revision:5783; number_of_response:1; }","duration":"101.202133ms","start":"2026-04-18T22:18:37.975923Z","end":"2026-04-18T22:18:38.077125Z","steps":["trace[383242227] 'process raft request' (duration: 100.469391ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:14.245242Z","caller":"traceutil/trace.go:171","msg":"trace[1908927938] transaction","detail":"{read_only:false; response_revision:5962; number_of_response:1; }","duration":"152.559157ms","start":"2026-04-18T22:19:14.092659Z","end":"2026-04-18T22:19:14.245218Z","steps":["trace[1908927938] 'process raft request' (duration: 152.409965ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:14.245541Z","caller":"traceutil/trace.go:171","msg":"trace[447484403] transaction","detail":"{read_only:false; response_revision:5961; number_of_response:1; }","duration":"155.378839ms","start":"2026-04-18T22:19:14.090054Z","end":"2026-04-18T22:19:14.245433Z","steps":["trace[447484403] 'process raft request' (duration: 154.0866ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:20:26.7797Z","caller":"traceutil/trace.go:171","msg":"trace[1988656860] transaction","detail":"{read_only:false; response_revision:6536; number_of_response:1; }","duration":"144.655753ms","start":"2026-04-18T22:20:26.635022Z","end":"2026-04-18T22:20:26.779678Z","steps":["trace[1988656860] 'process raft request' (duration: 144.597742ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:20:26.779928Z","caller":"traceutil/trace.go:171","msg":"trace[1245002352] transaction","detail":"{read_only:false; response_revision:6535; number_of_response:1; }","duration":"145.17913ms","start":"2026-04-18T22:20:26.634736Z","end":"2026-04-18T22:20:26.779915Z","steps":["trace[1245002352] 'process raft request' (duration: 144.847366ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:20:26.779919Z","caller":"traceutil/trace.go:171","msg":"trace[2019299504] transaction","detail":"{read_only:false; response_revision:6534; number_of_response:1; }","duration":"145.216831ms","start":"2026-04-18T22:20:26.63467Z","end":"2026-04-18T22:20:26.779887Z","steps":["trace[2019299504] 'process raft request' (duration: 122.968391ms)","trace[2019299504] 'compare' (duration: 21.856145ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:20:44.691723Z","caller":"traceutil/trace.go:171","msg":"trace[1929435651] linearizableReadLoop","detail":"{readStateIndex:6923; appliedIndex:6921; }","duration":"136.830125ms","start":"2026-04-18T22:20:44.554874Z","end":"2026-04-18T22:20:44.691704Z","steps":["trace[1929435651] 'read index received' (duration: 25.231928ms)","trace[1929435651] 'applied index is now lower than readState.Index' (duration: 111.597367ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:20:44.691894Z","caller":"traceutil/trace.go:171","msg":"trace[1889985098] transaction","detail":"{read_only:false; response_revision:6675; number_of_response:1; }","duration":"137.991401ms","start":"2026-04-18T22:20:44.553895Z","end":"2026-04-18T22:20:44.691886Z","steps":["trace[1889985098] 'process raft request' (duration: 137.719348ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:20:44.69205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.161979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-18T22:20:44.692081Z","caller":"traceutil/trace.go:171","msg":"trace[640828454] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:6675; }","duration":"137.23342ms","start":"2026-04-18T22:20:44.554839Z","end":"2026-04-18T22:20:44.692073Z","steps":["trace[640828454] 'agreement among raft nodes before linearized reading' (duration: 137.173629ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:20:45.018561Z","caller":"traceutil/trace.go:171","msg":"trace[169256888] transaction","detail":"{read_only:false; response_revision:6681; number_of_response:1; }","duration":"118.004266ms","start":"2026-04-18T22:20:44.900539Z","end":"2026-04-18T22:20:45.018543Z","steps":["trace[169256888] 'process raft request' (duration: 117.882584ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:20:45.11207Z","caller":"traceutil/trace.go:171","msg":"trace[1168378957] transaction","detail":"{read_only:false; response_revision:6682; number_of_response:1; }","duration":"149.501499ms","start":"2026-04-18T22:20:44.962549Z","end":"2026-04-18T22:20:45.112051Z","steps":["trace[1168378957] 'process raft request' (duration: 149.042143ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:23:06.563652Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5572} {"level":"info","ts":"2026-04-18T22:23:06.671164Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5572,"took":"105.954007ms","hash":2495875289,"current-db-size-bytes":54112256,"current-db-size":"54 MB","current-db-size-in-use-bytes":18219008,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-18T22:23:06.6713Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2495875289,"revision":5572,"compact-revision":2921}