{"level":"warn","ts":"2026-05-09T12:48:53.597454Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-09T12:48:53.597538Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.250: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.250:2380","--initial-cluster=instance=https://199.204.45.250:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.250:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.250:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-05-09T12:48:53.597613Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-09T12:48:53.597628Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.250:2380"]}
{"level":"info","ts":"2026-05-09T12:48:53.59765Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-09T12:48:53.598319Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"]}
{"level":"info","ts":"2026-05-09T12:48:53.598414Z","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.250:2380"],"listen-peer-urls":["https://199.204.45.250:2380"],"advertise-client-urls":["https://199.204.45.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.250:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-05-09T12:48:53.731381Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"132.725552ms"}
{"level":"info","ts":"2026-05-09T12:48:53.765643Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d98d5f2c752cc52d","cluster-id":"c785b4aaf4bd3b11"}
{"level":"info","ts":"2026-05-09T12:48:53.765994Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=()"}
{"level":"info","ts":"2026-05-09T12:48:53.766152Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became follower at term 0"}
{"level":"info","ts":"2026-05-09T12:48:53.766276Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d98d5f2c752cc52d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-09T12:48:53.7664Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became follower at term 1"}
{"level":"info","ts":"2026-05-09T12:48:53.766556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=(15676290522495632685)"}
{"level":"warn","ts":"2026-05-09T12:48:53.846184Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-09T12:48:53.850378Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-09T12:48:53.98339Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-05-09T12:48:54.039282Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d98d5f2c752cc52d","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-09T12:48:54.039837Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d98d5f2c752cc52d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-09T12:48:54.039883Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-09T12:48:54.040418Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-09T12:48:54.040438Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-09T12:48:54.042263Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=(15676290522495632685)"}
{"level":"info","ts":"2026-05-09T12:48:54.042376Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c785b4aaf4bd3b11","local-member-id":"d98d5f2c752cc52d","added-peer-id":"d98d5f2c752cc52d","added-peer-peer-urls":["https://199.204.45.250:2380"]}
{"level":"info","ts":"2026-05-09T12:48:54.042429Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d is starting a new election at term 1"}
{"level":"info","ts":"2026-05-09T12:48:54.042442Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-09T12:48:54.042462Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d received MsgPreVoteResp from d98d5f2c752cc52d at term 1"}
{"level":"info","ts":"2026-05-09T12:48:54.042475Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became candidate at term 2"}
{"level":"info","ts":"2026-05-09T12:48:54.042488Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d received MsgVoteResp from d98d5f2c752cc52d at term 2"}
{"level":"info","ts":"2026-05-09T12:48:54.042548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became leader at term 2"}
{"level":"info","ts":"2026-05-09T12:48:54.042566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d98d5f2c752cc52d elected leader d98d5f2c752cc52d at term 2"}
{"level":"info","ts":"2026-05-09T12:48:54.043221Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d98d5f2c752cc52d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.250:2379]}","request-path":"/0/members/d98d5f2c752cc52d/attributes","cluster-id":"c785b4aaf4bd3b11","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-09T12:48:54.043245Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-09T12:48:54.043987Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c785b4aaf4bd3b11","local-member-id":"d98d5f2c752cc52d","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-09T12:48:54.044117Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-09T12:48:54.044206Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-09T12:48:54.044475Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-09T12:48:54.044566Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.250:2380"}
{"level":"info","ts":"2026-05-09T12:48:54.044581Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.250:2380"}
{"level":"info","ts":"2026-05-09T12:48:54.045274Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-09T12:48:54.045689Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-09T12:48:54.047403Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.250:2379"}
{"level":"info","ts":"2026-05-09T12:48:54.048764Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-09T12:48:54.056018Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-09T12:48:54.053303Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d98d5f2c752cc52d","initial-advertise-peer-urls":["https://199.204.45.250:2380"],"listen-peer-urls":["https://199.204.45.250:2380"],"advertise-client-urls":["https://199.204.45.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-09T12:48:54.056592Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-09T12:48:54.056673Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-09T12:48:55.673714Z","caller":"traceutil/trace.go:171","msg":"trace[1260502117] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"358.711215ms","start":"2026-05-09T12:48:55.314981Z","end":"2026-05-09T12:48:55.673692Z","steps":["trace[1260502117] 'read index received'  (duration: 358.526123ms)","trace[1260502117] 'applied index is now lower than readState.Index'  (duration: 182.032µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:48:55.673767Z","caller":"traceutil/trace.go:171","msg":"trace[1744194540] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"361.561204ms","start":"2026-05-09T12:48:55.312177Z","end":"2026-05-09T12:48:55.673738Z","steps":["trace[1744194540] 'process raft request'  (duration: 361.285471ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:48:55.673972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.966239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-05-09T12:48:55.674028Z","caller":"traceutil/trace.go:171","msg":"trace[249218155] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:0; response_revision:2; }","duration":"359.044569ms","start":"2026-05-09T12:48:55.314969Z","end":"2026-05-09T12:48:55.674013Z","steps":["trace[249218155] 'agreement among raft nodes before linearized reading'  (duration: 358.840367ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:48:55.674053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:48:55.314963Z","time spent":"359.08382ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":0,"response size":28,"request content":"key:\"/registry/ranges/servicenodeports\" "}
{"level":"warn","ts":"2026-05-09T12:48:55.674656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:48:55.312163Z","time spent":"361.670175ms","remote":"127.0.0.1:36606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/ranges/serviceips\" mod_revision:0 > success:<request_put:<key:\"/registry/ranges/serviceips\" value_size:67 >> failure:<request_range:<key:\"/registry/ranges/serviceips\" > >"}
{"level":"info","ts":"2026-05-09T12:48:55.708336Z","caller":"traceutil/trace.go:171","msg":"trace[504314665] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"314.749792ms","start":"2026-05-09T12:48:55.393546Z","end":"2026-05-09T12:48:55.708296Z","steps":["trace[504314665] 'process raft request'  (duration: 314.502229ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:48:55.708655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.963259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-05-09T12:48:55.708731Z","caller":"traceutil/trace.go:171","msg":"trace[1461266508] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"246.09211ms","start":"2026-05-09T12:48:55.46262Z","end":"2026-05-09T12:48:55.708712Z","steps":["trace[1461266508] 'agreement among raft nodes before linearized reading'  (duration: 245.892798ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:48:55.708636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:48:55.393514Z","time spent":"315.000437ms","remote":"127.0.0.1:37090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.apiextensions.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.apiextensions.k8s.io\" value_size:892 >> failure:<>"}
{"level":"warn","ts":"2026-05-09T12:48:55.70889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.332973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-05-09T12:48:55.708846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.966169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.250\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-05-09T12:48:55.708711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.648024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"}
{"level":"info","ts":"2026-05-09T12:48:55.708946Z","caller":"traceutil/trace.go:171","msg":"trace[1923138265] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"301.510645ms","start":"2026-05-09T12:48:55.407427Z","end":"2026-05-09T12:48:55.708938Z","steps":["trace[1923138265] 'process raft request'  (duration: 300.992918ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:48:55.708943Z","caller":"traceutil/trace.go:171","msg":"trace[1968041284] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"304.405124ms","start":"2026-05-09T12:48:55.404526Z","end":"2026-05-09T12:48:55.708931Z","steps":["trace[1968041284] 'agreement among raft nodes before linearized reading'  (duration: 304.292242ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:48:55.708978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:48:55.404487Z","time spent":"304.483235ms","remote":"127.0.0.1:36658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-05-09T12:48:55.709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:48:55.407417Z","time spent":"301.544916ms","remote":"127.0.0.1:36830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/certificatesigningrequests/csr-4nd82\" mod_revision:0 > success:<request_put:<key:\"/registry/certificatesigningrequests/csr-4nd82\" value_size:795 >> failure:<>"}
{"level":"info","ts":"2026-05-09T12:48:55.708992Z","caller":"traceutil/trace.go:171","msg":"trace[788211286] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:10; }","duration":"393.921867ms","start":"2026-05-09T12:48:55.315036Z","end":"2026-05-09T12:48:55.708957Z","steps":["trace[788211286] 'agreement among raft nodes before linearized reading'  (duration: 393.462522ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:48:55.709049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:48:55.315033Z","time spent":"393.999888ms","remote":"127.0.0.1:36732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3195,"request content":"key:\"/registry/minions/instance\" "}
{"level":"info","ts":"2026-05-09T12:48:55.709092Z","caller":"traceutil/trace.go:171","msg":"trace[1676634172] range","detail":"{range_begin:/registry/masterleases/199.204.45.250; range_end:; response_count:0; response_revision:10; }","duration":"316.234283ms","start":"2026-05-09T12:48:55.39271Z","end":"2026-05-09T12:48:55.708945Z","steps":["trace[1676634172] 'agreement among raft nodes before linearized reading'  (duration: 315.939619ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:48:55.709138Z","caller":"traceutil/trace.go:171","msg":"trace[568348804] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"298.831158ms","start":"2026-05-09T12:48:55.410301Z","end":"2026-05-09T12:48:55.709132Z","steps":["trace[568348804] 'process raft request'  (duration: 298.155149ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:48:55.709169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.107378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-05-09T12:48:55.709205Z","caller":"traceutil/trace.go:171","msg":"trace[2008891136] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"254.169369ms","start":"2026-05-09T12:48:55.455027Z","end":"2026-05-09T12:48:55.709196Z","steps":["trace[2008891136] 'agreement among raft nodes before linearized reading'  (duration: 254.119657ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:48:55.708372Z","caller":"traceutil/trace.go:171","msg":"trace[1049930585] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"314.680872ms","start":"2026-05-09T12:48:55.393667Z","end":"2026-05-09T12:48:55.708347Z","steps":["trace[1049930585] 'process raft request'  (duration: 314.56493ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:48:55.709343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.394792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-05-09T12:48:55.709394Z","caller":"traceutil/trace.go:171","msg":"trace[690243217] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"315.669655ms","start":"2026-05-09T12:48:55.393716Z","end":"2026-05-09T12:48:55.709386Z","steps":["trace[690243217] 'process raft request'  (duration: 314.59822ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:48:55.709423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:48:55.393696Z","time spent":"315.713556ms","remote":"127.0.0.1:37090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.authentication.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.authentication.k8s.io\" value_size:894 >> failure:<>"}
{"level":"info","ts":"2026-05-09T12:48:55.7095Z","caller":"traceutil/trace.go:171","msg":"trace[924882130] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"315.805047ms","start":"2026-05-09T12:48:55.39369Z","end":"2026-05-09T12:48:55.709495Z","steps":["trace[924882130] 'process raft request'  (duration: 314.59108ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:48:55.709508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.600144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-05-09T12:48:55.70961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.745836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-05-09T12:48:55.709632Z","caller":"traceutil/trace.go:171","msg":"trace[1190724241] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"341.894257ms","start":"2026-05-09T12:48:55.367732Z","end":"2026-05-09T12:48:55.709626Z","steps":["trace[1190724241] 'agreement among raft nodes before linearized reading'  (duration: 341.860077ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:48:55.709346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:48:55.393659Z","time spent":"315.639465ms","remote":"127.0.0.1:37090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.admissionregistration.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.admissionregistration.k8s.io\" value_size:908 >> failure:<>"}
{"level":"warn","ts":"2026-05-09T12:48:55.709661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:48:55.367713Z","time spent":"341.943759ms","remote":"127.0.0.1:36658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"info","ts":"2026-05-09T12:48:55.70962Z","caller":"traceutil/trace.go:171","msg":"trace[61678440] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"341.869387ms","start":"2026-05-09T12:48:55.367732Z","end":"2026-05-09T12:48:55.709602Z","steps":["trace[61678440] 'agreement among raft nodes before linearized reading'  (duration: 341.709125ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:48:55.709756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:48:55.367698Z","time spent":"342.05115ms","remote":"127.0.0.1:36658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"info","ts":"2026-05-09T12:48:55.709388Z","caller":"traceutil/trace.go:171","msg":"trace[31892668] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"315.461663ms","start":"2026-05-09T12:48:55.393913Z","end":"2026-05-09T12:48:55.709375Z","steps":["trace[31892668] 'agreement among raft nodes before linearized reading'  (duration: 315.377242ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:48:55.70987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:48:55.393879Z","time spent":"315.98382ms","remote":"127.0.0.1:36634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "}
{"level":"warn","ts":"2026-05-09T12:48:55.709525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:48:55.393665Z","time spent":"315.849918ms","remote":"127.0.0.1:37090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.apps\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.apps\" value_size:860 >> failure:<>"}
{"level":"warn","ts":"2026-05-09T12:48:55.709262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:48:55.392676Z","time spent":"316.466316ms","remote":"127.0.0.1:36572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":28,"request content":"key:\"/registry/masterleases/199.204.45.250\" "}
{"level":"info","ts":"2026-05-09T12:48:55.70875Z","caller":"traceutil/trace.go:171","msg":"trace[303049364] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"313.04188ms","start":"2026-05-09T12:48:55.395661Z","end":"2026-05-09T12:48:55.708703Z","steps":["trace[303049364] 'process raft request'  (duration: 312.717965ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:48:55.710151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:48:55.39565Z","time spent":"314.363248ms","remote":"127.0.0.1:36998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/prioritylevelconfigurations/system\" mod_revision:0 > success:<request_put:<key:\"/registry/prioritylevelconfigurations/system\" value_size:646 >> failure:<>"}
{"level":"info","ts":"2026-05-09T12:48:55.710263Z","caller":"traceutil/trace.go:171","msg":"trace[22747429] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"316.124121ms","start":"2026-05-09T12:48:55.394132Z","end":"2026-05-09T12:48:55.710256Z","steps":["trace[22747429] 'process raft request'  (duration: 314.217135ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:48:55.710308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:48:55.394081Z","time spent":"316.209563ms","remote":"127.0.0.1:37090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.\" value_size:827 >> failure:<>"}
{"level":"warn","ts":"2026-05-09T12:48:55.711964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.264872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-05-09T12:48:55.712078Z","caller":"traceutil/trace.go:171","msg":"trace[4067093] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:10; }","duration":"396.982059ms","start":"2026-05-09T12:48:55.315077Z","end":"2026-05-09T12:48:55.712059Z","steps":["trace[4067093] 'agreement among raft nodes before linearized reading'  (duration: 394.293003ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:48:55.712258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:48:55.315056Z","time spent":"397.05244ms","remote":"127.0.0.1:36958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":28,"request content":"key:\"/registry/csinodes/instance\" "}
{"level":"info","ts":"2026-05-09T12:48:58.565341Z","caller":"traceutil/trace.go:171","msg":"trace[662565323] transaction","detail":"{read_only:false; response_revision:221; number_of_response:1; }","duration":"116.841744ms","start":"2026-05-09T12:48:58.448473Z","end":"2026-05-09T12:48:58.565315Z","steps":["trace[662565323] 'process raft request'  (duration: 86.38ms)","trace[662565323] 'compare'  (duration: 30.343243ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:48:58.684119Z","caller":"traceutil/trace.go:171","msg":"trace[1948502917] transaction","detail":"{read_only:false; response_revision:223; number_of_response:1; }","duration":"108.701068ms","start":"2026-05-09T12:48:58.575392Z","end":"2026-05-09T12:48:58.684093Z","steps":["trace[1948502917] 'process raft request'  (duration: 107.993219ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:48:58.802272Z","caller":"traceutil/trace.go:171","msg":"trace[508861122] transaction","detail":"{read_only:false; response_revision:225; number_of_response:1; }","duration":"109.197396ms","start":"2026-05-09T12:48:58.693041Z","end":"2026-05-09T12:48:58.802239Z","steps":["trace[508861122] 'process raft request'  (duration: 108.282663ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:49:18.528768Z","caller":"traceutil/trace.go:171","msg":"trace[681363896] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"105.245921ms","start":"2026-05-09T12:49:18.423485Z","end":"2026-05-09T12:49:18.528731Z","steps":["trace[681363896] 'process raft request'  (duration: 105.048299ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:49:18.915266Z","caller":"traceutil/trace.go:171","msg":"trace[580852132] linearizableReadLoop","detail":"{readStateIndex:439; appliedIndex:438; }","duration":"265.463088ms","start":"2026-05-09T12:49:18.649787Z","end":"2026-05-09T12:49:18.91525Z","steps":["trace[580852132] 'read index received'  (duration: 265.322137ms)","trace[580852132] 'applied index is now lower than readState.Index'  (duration: 140.451µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T12:49:18.915347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.551459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T12:49:18.915363Z","caller":"traceutil/trace.go:171","msg":"trace[210099706] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:425; }","duration":"265.624109ms","start":"2026-05-09T12:49:18.649733Z","end":"2026-05-09T12:49:18.915357Z","steps":["trace[210099706] 'agreement among raft nodes before linearized reading'  (duration: 265.576629ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:49:18.915527Z","caller":"traceutil/trace.go:171","msg":"trace[1443991313] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"382.378804ms","start":"2026-05-09T12:49:18.53295Z","end":"2026-05-09T12:49:18.915328Z","steps":["trace[1443991313] 'process raft request'  (duration: 382.214673ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:49:18.915689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:49:18.532929Z","time spent":"382.679068ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:419 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-05-09T12:49:22.481154Z","caller":"traceutil/trace.go:171","msg":"trace[1177969525] transaction","detail":"{read_only:false; response_revision:437; number_of_response:1; }","duration":"195.747515ms","start":"2026-05-09T12:49:22.285381Z","end":"2026-05-09T12:49:22.481128Z","steps":["trace[1177969525] 'process raft request'  (duration: 147.020151ms)","trace[1177969525] 'compare'  (duration: 48.3683ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:49:22.481427Z","caller":"traceutil/trace.go:171","msg":"trace[1471331644] transaction","detail":"{read_only:false; response_revision:438; number_of_response:1; }","duration":"195.539133ms","start":"2026-05-09T12:49:22.285846Z","end":"2026-05-09T12:49:22.481385Z","steps":["trace[1471331644] 'process raft request'  (duration: 195.077848ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:49:22.741112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.406228ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14208186177166117354 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:429 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-09T12:49:22.741232Z","caller":"traceutil/trace.go:171","msg":"trace[2109332161] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"168.647085ms","start":"2026-05-09T12:49:22.572566Z","end":"2026-05-09T12:49:22.741213Z","steps":["trace[2109332161] 'process raft request'  (duration: 14.894134ms)","trace[2109332161] 'compare'  (duration: 153.246715ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:49:22.900448Z","caller":"traceutil/trace.go:171","msg":"trace[1888922317] linearizableReadLoop","detail":"{readStateIndex:459; appliedIndex:458; }","duration":"246.724212ms","start":"2026-05-09T12:49:22.653696Z","end":"2026-05-09T12:49:22.90042Z","steps":["trace[1888922317] 'read index received'  (duration: 245.538441ms)","trace[1888922317] 'applied index is now lower than readState.Index'  (duration: 1.184661ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:49:22.900551Z","caller":"traceutil/trace.go:171","msg":"trace[1232577204] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"325.158005ms","start":"2026-05-09T12:49:22.575352Z","end":"2026-05-09T12:49:22.90051Z","steps":["trace[1232577204] 'process raft request'  (duration: 323.912502ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:49:22.900597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.879115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-09T12:49:22.900734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:49:22.575331Z","time spent":"325.324546ms","remote":"127.0.0.1:37032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14213,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/daemonsets/kube-system/cilium\" mod_revision:0 > success:<request_put:<key:\"/registry/daemonsets/kube-system/cilium\" value_size:14166 >> failure:<>"}
{"level":"info","ts":"2026-05-09T12:49:22.900813Z","caller":"traceutil/trace.go:171","msg":"trace[198300587] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:444; }","duration":"247.214588ms","start":"2026-05-09T12:49:22.653581Z","end":"2026-05-09T12:49:22.900796Z","steps":["trace[198300587] 'agreement among raft nodes before linearized reading'  (duration: 246.936565ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:49:23.148717Z","caller":"traceutil/trace.go:171","msg":"trace[89556093] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"237.722118ms","start":"2026-05-09T12:49:22.910972Z","end":"2026-05-09T12:49:23.148695Z","steps":["trace[89556093] 'process raft request'  (duration: 224.107149ms)","trace[89556093] 'compare'  (duration: 13.510418ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:49:23.16923Z","caller":"traceutil/trace.go:171","msg":"trace[1649560139] linearizableReadLoop","detail":"{readStateIndex:461; appliedIndex:459; }","duration":"221.673831ms","start":"2026-05-09T12:49:22.94753Z","end":"2026-05-09T12:49:23.169204Z","steps":["trace[1649560139] 'read index received'  (duration: 187.530141ms)","trace[1649560139] 'applied index is now lower than readState.Index'  (duration: 34.14297ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T12:49:23.169359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.820043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-09T12:49:23.169387Z","caller":"traceutil/trace.go:171","msg":"trace[192735716] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:446; }","duration":"221.865513ms","start":"2026-05-09T12:49:22.947514Z","end":"2026-05-09T12:49:23.16938Z","steps":["trace[192735716] 'agreement among raft nodes before linearized reading'  (duration: 221.772223ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:49:23.169441Z","caller":"traceutil/trace.go:171","msg":"trace[699347987] transaction","detail":"{read_only:false; response_revision:446; number_of_response:1; }","duration":"258.404992ms","start":"2026-05-09T12:49:22.911012Z","end":"2026-05-09T12:49:23.169417Z","steps":["trace[699347987] 'process raft request'  (duration: 258.090228ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:49:23.38374Z","caller":"traceutil/trace.go:171","msg":"trace[1121592722] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"202.603232ms","start":"2026-05-09T12:49:23.181113Z","end":"2026-05-09T12:49:23.383716Z","steps":["trace[1121592722] 'process raft request'  (duration: 202.537892ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:49:23.383899Z","caller":"traceutil/trace.go:171","msg":"trace[468396774] transaction","detail":"{read_only:false; response_revision:448; number_of_response:1; }","duration":"209.016077ms","start":"2026-05-09T12:49:23.174829Z","end":"2026-05-09T12:49:23.383845Z","steps":["trace[468396774] 'process raft request'  (duration: 202.091306ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:49:23.448073Z","caller":"traceutil/trace.go:171","msg":"trace[100031024] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"245.611664ms","start":"2026-05-09T12:49:23.202437Z","end":"2026-05-09T12:49:23.448049Z","steps":["trace[100031024] 'process raft request'  (duration: 245.401321ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:49:23.448129Z","caller":"traceutil/trace.go:171","msg":"trace[1754519115] transaction","detail":"{read_only:false; response_revision:451; number_of_response:1; }","duration":"245.646564ms","start":"2026-05-09T12:49:23.202448Z","end":"2026-05-09T12:49:23.448095Z","steps":["trace[1754519115] 'process raft request'  (duration: 245.489833ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:49:23.448748Z","caller":"traceutil/trace.go:171","msg":"trace[98854746] transaction","detail":"{read_only:false; response_revision:452; number_of_response:1; }","duration":"244.737245ms","start":"2026-05-09T12:49:23.203964Z","end":"2026-05-09T12:49:23.448701Z","steps":["trace[98854746] 'process raft request'  (duration: 244.023298ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:49:23.449042Z","caller":"traceutil/trace.go:171","msg":"trace[415144072] transaction","detail":"{read_only:false; response_revision:453; number_of_response:1; }","duration":"210.439831ms","start":"2026-05-09T12:49:23.238579Z","end":"2026-05-09T12:49:23.449019Z","steps":["trace[415144072] 'process raft request'  (duration: 209.741844ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:49:23.652773Z","caller":"traceutil/trace.go:171","msg":"trace[1980734411] transaction","detail":"{read_only:false; response_revision:454; number_of_response:1; }","duration":"264.122103ms","start":"2026-05-09T12:49:23.388614Z","end":"2026-05-09T12:49:23.652736Z","steps":["trace[1980734411] 'process raft request'  (duration: 182.166101ms)","trace[1980734411] 'compare'  (duration: 81.70066ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:49:23.653285Z","caller":"traceutil/trace.go:171","msg":"trace[1211846038] transaction","detail":"{read_only:false; response_revision:455; number_of_response:1; }","duration":"264.545328ms","start":"2026-05-09T12:49:23.388732Z","end":"2026-05-09T12:49:23.653277Z","steps":["trace[1211846038] 'process raft request'  (duration: 263.951181ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:49:23.653279Z","caller":"traceutil/trace.go:171","msg":"trace[2100523484] transaction","detail":"{read_only:false; response_revision:459; number_of_response:1; }","duration":"195.730952ms","start":"2026-05-09T12:49:23.457529Z","end":"2026-05-09T12:49:23.65326Z","steps":["trace[2100523484] 'process raft request'  (duration: 195.651921ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:49:23.653491Z","caller":"traceutil/trace.go:171","msg":"trace[358366084] transaction","detail":"{read_only:false; response_revision:456; number_of_response:1; }","duration":"257.412904ms","start":"2026-05-09T12:49:23.396065Z","end":"2026-05-09T12:49:23.653478Z","steps":["trace[358366084] 'process raft request'  (duration: 256.696257ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:49:23.653518Z","caller":"traceutil/trace.go:171","msg":"trace[2147460536] transaction","detail":"{read_only:false; response_revision:458; number_of_response:1; }","duration":"196.221516ms","start":"2026-05-09T12:49:23.457289Z","end":"2026-05-09T12:49:23.653511Z","steps":["trace[2147460536] 'process raft request'  (duration: 195.558089ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:49:23.653578Z","caller":"traceutil/trace.go:171","msg":"trace[374950368] transaction","detail":"{read_only:false; response_revision:457; number_of_response:1; }","duration":"196.689691ms","start":"2026-05-09T12:49:23.456883Z","end":"2026-05-09T12:49:23.653572Z","steps":["trace[374950368] 'process raft request'  (duration: 195.931494ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:49:23.653579Z","caller":"traceutil/trace.go:171","msg":"trace[465640154] linearizableReadLoop","detail":"{readStateIndex:471; appliedIndex:468; }","duration":"196.929283ms","start":"2026-05-09T12:49:23.456615Z","end":"2026-05-09T12:49:23.653545Z","steps":["trace[465640154] 'read index received'  (duration: 114.121593ms)","trace[465640154] 'applied index is now lower than readState.Index'  (duration: 82.8038ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T12:49:23.653783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.148096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/cilium-operator\" ","response":"range_response_count:1 size:4335"}
{"level":"info","ts":"2026-05-09T12:49:23.653806Z","caller":"traceutil/trace.go:171","msg":"trace[1449851139] range","detail":"{range_begin:/registry/deployments/kube-system/cilium-operator; range_end:; response_count:1; response_revision:459; }","duration":"197.211536ms","start":"2026-05-09T12:49:23.456587Z","end":"2026-05-09T12:49:23.653799Z","steps":["trace[1449851139] 'agreement among raft nodes before linearized reading'  (duration: 197.071324ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:49:23.65397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.78268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329952"}
{"level":"info","ts":"2026-05-09T12:49:23.654013Z","caller":"traceutil/trace.go:171","msg":"trace[1424603633] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:459; }","duration":"114.83469ms","start":"2026-05-09T12:49:23.539163Z","end":"2026-05-09T12:49:23.653998Z","steps":["trace[1424603633] 'agreement among raft nodes before linearized reading'  (duration: 114.610278ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:49:23.950408Z","caller":"traceutil/trace.go:171","msg":"trace[2138734530] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"205.564152ms","start":"2026-05-09T12:49:23.744789Z","end":"2026-05-09T12:49:23.950353Z","steps":["trace[2138734530] 'process raft request'  (duration: 195.181575ms)","trace[2138734530] 'compare'  (duration: 10.268526ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:49:23.954621Z","caller":"traceutil/trace.go:171","msg":"trace[408411366] linearizableReadLoop","detail":"{readStateIndex:481; appliedIndex:479; }","duration":"175.900987ms","start":"2026-05-09T12:49:23.778698Z","end":"2026-05-09T12:49:23.954599Z","steps":["trace[408411366] 'read index received'  (duration: 161.295397ms)","trace[408411366] 'applied index is now lower than readState.Index'  (duration: 14.60456ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:49:23.954782Z","caller":"traceutil/trace.go:171","msg":"trace[399475784] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"209.608844ms","start":"2026-05-09T12:49:23.745159Z","end":"2026-05-09T12:49:23.954768Z","steps":["trace[399475784] 'process raft request'  (duration: 209.3312ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:49:23.955352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.637555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329952"}
{"level":"info","ts":"2026-05-09T12:49:23.955452Z","caller":"traceutil/trace.go:171","msg":"trace[2077591828] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:466; }","duration":"176.787026ms","start":"2026-05-09T12:49:23.778643Z","end":"2026-05-09T12:49:23.95543Z","steps":["trace[2077591828] 'agreement among raft nodes before linearized reading'  (duration: 176.355852ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:49:26.516788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.331395ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14208186177166117466 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io\" mod_revision:523 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io\" value_size:65302 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-09T12:49:26.516931Z","caller":"traceutil/trace.go:171","msg":"trace[814281822] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"540.415655ms","start":"2026-05-09T12:49:25.976488Z","end":"2026-05-09T12:49:26.516903Z","steps":["trace[814281822] 'process raft request'  (duration: 106.839818ms)","trace[814281822] 'compare'  (duration: 433.238924ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T12:49:26.517019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:49:25.976458Z","time spent":"540.516747ms","remote":"127.0.0.1:36592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65412,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io\" mod_revision:523 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io\" value_size:65302 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-05-09T12:49:26.744526Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186177166117453,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-09T12:49:27.245591Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186177166117453,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-09T12:49:27.746721Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186177166117453,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-09T12:49:28.071826Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.988521209s","expected-duration":"1s"}
{"level":"info","ts":"2026-05-09T12:49:28.072435Z","caller":"traceutil/trace.go:171","msg":"trace[1532830014] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"2.055640684s","start":"2026-05-09T12:49:26.016762Z","end":"2026-05-09T12:49:28.072402Z","steps":["trace[1532830014] 'process raft request'  (duration: 2.055450393s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:49:28.072673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:49:26.01672Z","time spent":"2.055842897s","remote":"127.0.0.1:36592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18041,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backends.gateway.envoyproxy.io\" mod_revision:528 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backends.gateway.envoyproxy.io\" value_size:17944 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backends.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-09T12:49:28.192022Z","caller":"traceutil/trace.go:171","msg":"trace[1936914056] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"1.994460954s","start":"2026-05-09T12:49:26.19743Z","end":"2026-05-09T12:49:28.191891Z","steps":["trace[1936914056] 'process raft request'  (duration: 1.940247755s)","trace[1936914056] 'compare'  (duration: 52.842616ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T12:49:28.192185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:49:26.197384Z","time spent":"1.994727616s","remote":"127.0.0.1:36592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" value_size:568993 >> failure:<>"}
{"level":"info","ts":"2026-05-09T12:49:28.19231Z","caller":"traceutil/trace.go:171","msg":"trace[883365160] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"1.644299986s","start":"2026-05-09T12:49:26.547978Z","end":"2026-05-09T12:49:28.192278Z","steps":["trace[883365160] 'process raft request'  (duration: 1.643885232s)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:49:28.192425Z","caller":"traceutil/trace.go:171","msg":"trace[1261644602] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"1.270748705s","start":"2026-05-09T12:49:26.921647Z","end":"2026-05-09T12:49:28.192396Z","steps":["trace[1261644602] 'process raft request'  (duration: 1.27035722s)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:49:28.192388Z","caller":"traceutil/trace.go:171","msg":"trace[236778928] linearizableReadLoop","detail":"{readStateIndex:553; appliedIndex:549; }","duration":"1.948707803s","start":"2026-05-09T12:49:26.243605Z","end":"2026-05-09T12:49:28.192313Z","steps":["trace[236778928] 'read index received'  (duration: 1.828596259s)","trace[236778928] 'applied index is now lower than readState.Index'  (duration: 120.108504ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T12:49:28.192596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.948921526s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-05-09T12:49:28.192609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:49:26.921622Z","time spent":"1.270883066s","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:420 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-05-09T12:49:28.192628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:49:26.547951Z","time spent":"1.644502749s","remote":"127.0.0.1:36592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":74745,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyextensionpolicies.gateway.envoyproxy.io\" mod_revision:527 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyextensionpolicies.gateway.envoyproxy.io\" value_size:74634 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyextensionpolicies.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-09T12:49:28.192652Z","caller":"traceutil/trace.go:171","msg":"trace[1846990606] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:537; }","duration":"1.949054237s","start":"2026-05-09T12:49:26.243586Z","end":"2026-05-09T12:49:28.19264Z","steps":["trace[1846990606] 'agreement among raft nodes before linearized reading'  (duration: 1.948828715s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:49:28.192717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:49:26.243505Z","time spent":"1.949200387s","remote":"127.0.0.1:36842","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-05-09T12:49:28.19277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.539571422s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T12:49:28.19281Z","caller":"traceutil/trace.go:171","msg":"trace[224019848] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:537; }","duration":"1.539638152s","start":"2026-05-09T12:49:26.653162Z","end":"2026-05-09T12:49:28.1928Z","steps":["trace[224019848] 'agreement among raft nodes before linearized reading'  (duration: 1.539573692s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:49:28.192839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:49:26.653145Z","time spent":"1.539688512s","remote":"127.0.0.1:36540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-09T12:49:28.192863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.250105536s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.250\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-05-09T12:49:28.192916Z","caller":"traceutil/trace.go:171","msg":"trace[1730225187] range","detail":"{range_begin:/registry/masterleases/199.204.45.250; range_end:; response_count:1; response_revision:537; }","duration":"1.250182796s","start":"2026-05-09T12:49:26.942716Z","end":"2026-05-09T12:49:28.192899Z","steps":["trace[1730225187] 'agreement among raft nodes before linearized reading'  (duration: 1.250091495s)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:49:28.192961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:49:26.942701Z","time spent":"1.250249137s","remote":"127.0.0.1:36572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.204.45.250\" "}
{"level":"warn","ts":"2026-05-09T12:49:28.192962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"727.122886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-05-09T12:49:28.192984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.378841652s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-09T12:49:28.193077Z","caller":"traceutil/trace.go:171","msg":"trace[1361249235] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:537; }","duration":"1.378983673s","start":"2026-05-09T12:49:26.81407Z","end":"2026-05-09T12:49:28.193053Z","steps":["trace[1361249235] 'agreement among raft nodes before linearized reading'  (duration: 1.378771962s)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:49:28.193084Z","caller":"traceutil/trace.go:171","msg":"trace[1477622090] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:537; }","duration":"727.280558ms","start":"2026-05-09T12:49:27.465766Z","end":"2026-05-09T12:49:28.193047Z","steps":["trace[1477622090] 'agreement among raft nodes before linearized reading'  (duration: 726.987476ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:49:28.193111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:49:26.814053Z","time spent":"1.379052035s","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-09T12:49:28.19314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.167434ms","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-05-09T12:49:28.193158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:49:27.465744Z","time spent":"727.39659ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-05-09T12:49:28.193206Z","caller":"traceutil/trace.go:171","msg":"trace[268409495] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:537; }","duration":"417.375387ms","start":"2026-05-09T12:49:27.775806Z","end":"2026-05-09T12:49:28.193181Z","steps":["trace[268409495] 'agreement among raft nodes before linearized reading'  (duration: 417.006533ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:49:28.193245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:49:27.775757Z","time spent":"417.478928ms","remote":"127.0.0.1:36842","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-05-09T12:49:29.000437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.239383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backends.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:18056"}
{"level":"info","ts":"2026-05-09T12:49:29.000532Z","caller":"traceutil/trace.go:171","msg":"trace[1272531118] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backends.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:553; }","duration":"196.378374ms","start":"2026-05-09T12:49:28.804131Z","end":"2026-05-09T12:49:29.000509Z","steps":["trace[1272531118] 'range keys from in-memory index tree'  (duration: 195.151041ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:49:29.000887Z","caller":"traceutil/trace.go:171","msg":"trace[330625644] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"153.429896ms","start":"2026-05-09T12:49:28.847426Z","end":"2026-05-09T12:49:29.000856Z","steps":["trace[330625644] 'process raft request'  (duration: 153.070783ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:49:36.741236Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186177166117668,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-05-09T12:49:36.961472Z","caller":"traceutil/trace.go:171","msg":"trace[1129178888] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:613; }","duration":"720.545323ms","start":"2026-05-09T12:49:36.240905Z","end":"2026-05-09T12:49:36.96145Z","steps":["trace[1129178888] 'read index received'  (duration: 720.372402ms)","trace[1129178888] 'applied index is now lower than readState.Index'  (duration: 172.061µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:49:36.961697Z","caller":"traceutil/trace.go:171","msg":"trace[556260161] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"723.921005ms","start":"2026-05-09T12:49:36.237739Z","end":"2026-05-09T12:49:36.96166Z","steps":["trace[556260161] 'process raft request'  (duration: 723.599371ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:49:36.961802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"715.575816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-05-09T12:49:36.961883Z","caller":"traceutil/trace.go:171","msg":"trace[1122238984] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:595; }","duration":"715.860428ms","start":"2026-05-09T12:49:36.246005Z","end":"2026-05-09T12:49:36.961865Z","steps":["trace[1122238984] 'agreement among raft nodes before linearized reading'  (duration: 715.711667ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:49:36.961936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:49:36.24599Z","time spent":"715.93316ms","remote":"127.0.0.1:36842","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-05-09T12:49:36.961822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:49:36.237717Z","time spent":"724.036888ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:587 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:429 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-05-09T12:49:36.962079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"711.630977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-05-09T12:49:36.962132Z","caller":"traceutil/trace.go:171","msg":"trace[694800402] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:595; }","duration":"711.695389ms","start":"2026-05-09T12:49:36.250421Z","end":"2026-05-09T12:49:36.962116Z","steps":["trace[694800402] 'agreement among raft nodes before linearized reading'  (duration: 711.606698ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:49:36.962173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:49:36.250414Z","time spent":"711.748929ms","remote":"127.0.0.1:36842","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-05-09T12:49:36.96239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.478023ms","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-05-09T12:49:36.962607Z","caller":"traceutil/trace.go:171","msg":"trace[215889114] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:595; }","duration":"721.614213ms","start":"2026-05-09T12:49:36.240869Z","end":"2026-05-09T12:49:36.962483Z","steps":["trace[215889114] 'agreement among raft nodes before linearized reading'  (duration: 720.755856ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:49:36.962673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:49:36.240855Z","time spent":"721.801995ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-05-09T12:49:38.94714Z","caller":"traceutil/trace.go:171","msg":"trace[2045050423] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"239.693632ms","start":"2026-05-09T12:49:38.707423Z","end":"2026-05-09T12:49:38.947116Z","steps":["trace[2045050423] 'process raft request'  (duration: 239.495479ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:49:39.886007Z","caller":"traceutil/trace.go:171","msg":"trace[522333913] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"177.269135ms","start":"2026-05-09T12:49:39.708719Z","end":"2026-05-09T12:49:39.885988Z","steps":["trace[522333913] 'process raft request'  (duration: 177.151944ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:49:45.508755Z","caller":"traceutil/trace.go:171","msg":"trace[66095668] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"100.614051ms","start":"2026-05-09T12:49:45.408117Z","end":"2026-05-09T12:49:45.508731Z","steps":["trace[66095668] 'process raft request'  (duration: 100.4756ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:49:50.454106Z","caller":"traceutil/trace.go:171","msg":"trace[1650615162] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"208.234533ms","start":"2026-05-09T12:49:50.245817Z","end":"2026-05-09T12:49:50.454051Z","steps":["trace[1650615162] 'process raft request'  (duration: 202.318405ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:49:53.825611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"786.123307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"warn","ts":"2026-05-09T12:49:53.825628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"785.512739ms","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-05-09T12:49:53.825735Z","caller":"traceutil/trace.go:171","msg":"trace[1142522923] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:756; }","duration":"786.246893ms","start":"2026-05-09T12:49:53.039461Z","end":"2026-05-09T12:49:53.825708Z","steps":["trace[1142522923] 'range keys from in-memory index tree'  (duration: 785.976881ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:49:53.825747Z","caller":"traceutil/trace.go:171","msg":"trace[1243045901] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:756; }","duration":"785.679297ms","start":"2026-05-09T12:49:53.040048Z","end":"2026-05-09T12:49:53.825727Z","steps":["trace[1243045901] 'range keys from in-memory index tree'  (duration: 785.339701ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:49:53.825654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"786.227391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-05-09T12:49:53.825785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:49:53.039409Z","time spent":"786.366508ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-09T12:49:53.825791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:49:53.040036Z","time spent":"785.745369ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-09T12:49:53.825611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"785.51927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-05-09T12:49:53.825828Z","caller":"traceutil/trace.go:171","msg":"trace[590816905] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:756; }","duration":"786.41964ms","start":"2026-05-09T12:49:53.039368Z","end":"2026-05-09T12:49:53.825788Z","steps":["trace[590816905] 'range keys from in-memory index tree'  (duration: 786.022133ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:49:53.82584Z","caller":"traceutil/trace.go:171","msg":"trace[1849031407] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:756; }","duration":"785.778021ms","start":"2026-05-09T12:49:53.040044Z","end":"2026-05-09T12:49:53.825822Z","steps":["trace[1849031407] 'range keys from in-memory index tree'  (duration: 785.32315ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:49:53.825884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:49:53.040028Z","time spent":"785.845104ms","remote":"127.0.0.1:36842","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-05-09T12:49:53.825886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:49:53.039349Z","time spent":"786.520495ms","remote":"127.0.0.1:36842","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-05-09T12:49:53.865814Z","caller":"traceutil/trace.go:171","msg":"trace[1536643927] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"184.395704ms","start":"2026-05-09T12:49:53.681401Z","end":"2026-05-09T12:49:53.865797Z","steps":["trace[1536643927] 'process raft request'  (duration: 184.250677ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:50:12.787552Z","caller":"traceutil/trace.go:171","msg":"trace[1609513197] transaction","detail":"{read_only:false; response_revision:1072; number_of_response:1; }","duration":"102.256281ms","start":"2026-05-09T12:50:12.685267Z","end":"2026-05-09T12:50:12.787523Z","steps":["trace[1609513197] 'process raft request'  (duration: 96.863893ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:50:13.002101Z","caller":"traceutil/trace.go:171","msg":"trace[890251894] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"150.088492ms","start":"2026-05-09T12:50:12.851996Z","end":"2026-05-09T12:50:13.002084Z","steps":["trace[890251894] 'process raft request'  (duration: 145.805473ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:50:13.009704Z","caller":"traceutil/trace.go:171","msg":"trace[1436926638] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"144.637357ms","start":"2026-05-09T12:50:12.865053Z","end":"2026-05-09T12:50:13.009691Z","steps":["trace[1436926638] 'process raft request'  (duration: 144.424368ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:50:13.009786Z","caller":"traceutil/trace.go:171","msg":"trace[1525744769] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"157.662128ms","start":"2026-05-09T12:50:12.852072Z","end":"2026-05-09T12:50:13.009734Z","steps":["trace[1525744769] 'process raft request'  (duration: 157.337406ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:50:18.697694Z","caller":"traceutil/trace.go:171","msg":"trace[1558171748] transaction","detail":"{read_only:false; response_revision:1130; number_of_response:1; }","duration":"135.389536ms","start":"2026-05-09T12:50:18.562275Z","end":"2026-05-09T12:50:18.697664Z","steps":["trace[1558171748] 'process raft request'  (duration: 98.581117ms)","trace[1558171748] 'compare'  (duration: 36.613862ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:50:25.265247Z","caller":"traceutil/trace.go:171","msg":"trace[1263175666] transaction","detail":"{read_only:false; response_revision:1166; number_of_response:1; }","duration":"497.40706ms","start":"2026-05-09T12:50:24.767803Z","end":"2026-05-09T12:50:25.26521Z","steps":["trace[1263175666] 'process raft request'  (duration: 497.218234ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:50:25.26562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:50:24.767763Z","time spent":"497.587315ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1160 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-05-09T12:50:25.266021Z","caller":"traceutil/trace.go:171","msg":"trace[700366353] linearizableReadLoop","detail":"{readStateIndex:1199; appliedIndex:1197; }","duration":"136.268287ms","start":"2026-05-09T12:50:25.129734Z","end":"2026-05-09T12:50:25.266002Z","steps":["trace[700366353] 'read index received'  (duration: 135.275675ms)","trace[700366353] 'applied index is now lower than readState.Index'  (duration: 991.952µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T12:50:25.266118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.382241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T12:50:25.266157Z","caller":"traceutil/trace.go:171","msg":"trace[1731450323] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:1167; }","duration":"136.466584ms","start":"2026-05-09T12:50:25.12968Z","end":"2026-05-09T12:50:25.266146Z","steps":["trace[1731450323] 'agreement among raft nodes before linearized reading'  (duration: 136.392622ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:50:25.266232Z","caller":"traceutil/trace.go:171","msg":"trace[1433236220] transaction","detail":"{read_only:false; response_revision:1167; number_of_response:1; }","duration":"175.784088ms","start":"2026-05-09T12:50:25.09043Z","end":"2026-05-09T12:50:25.266214Z","steps":["trace[1433236220] 'process raft request'  (duration: 175.501379ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:50:39.091538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.102942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-admission-create-gfb96\" ","response":"range_response_count:1 size:4197"}
{"level":"info","ts":"2026-05-09T12:50:39.091598Z","caller":"traceutil/trace.go:171","msg":"trace[1424068294] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-admission-create-gfb96; range_end:; response_count:1; response_revision:1297; }","duration":"199.197475ms","start":"2026-05-09T12:50:38.892386Z","end":"2026-05-09T12:50:39.091584Z","steps":["trace[1424068294] 'range keys from in-memory index tree'  (duration: 198.946978ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:50:46.482448Z","caller":"traceutil/trace.go:171","msg":"trace[1601345769] transaction","detail":"{read_only:false; response_revision:1422; number_of_response:1; }","duration":"205.466369ms","start":"2026-05-09T12:50:46.276957Z","end":"2026-05-09T12:50:46.482423Z","steps":["trace[1601345769] 'process raft request'  (duration: 205.299085ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:50:46.482606Z","caller":"traceutil/trace.go:171","msg":"trace[1013970201] linearizableReadLoop","detail":"{readStateIndex:1464; appliedIndex:1462; }","duration":"147.114108ms","start":"2026-05-09T12:50:46.335464Z","end":"2026-05-09T12:50:46.482579Z","steps":["trace[1013970201] 'read index received'  (duration: 146.756749ms)","trace[1013970201] 'applied index is now lower than readState.Index'  (duration: 355.769µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:50:46.482711Z","caller":"traceutil/trace.go:171","msg":"trace[1550348899] transaction","detail":"{read_only:false; response_revision:1423; number_of_response:1; }","duration":"205.645605ms","start":"2026-05-09T12:50:46.277045Z","end":"2026-05-09T12:50:46.48269Z","steps":["trace[1550348899] 'process raft request'  (duration: 205.341546ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:50:46.482852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.375726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-05-09T12:50:46.482888Z","caller":"traceutil/trace.go:171","msg":"trace[807256618] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1423; }","duration":"147.448827ms","start":"2026-05-09T12:50:46.335427Z","end":"2026-05-09T12:50:46.482876Z","steps":["trace[807256618] 'agreement among raft nodes before linearized reading'  (duration: 147.248382ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:51:09.383558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"697.544975ms","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-05-09T12:51:09.384032Z","caller":"traceutil/trace.go:171","msg":"trace[1540422375] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1812; }","duration":"698.084006ms","start":"2026-05-09T12:51:08.685923Z","end":"2026-05-09T12:51:09.384007Z","steps":["trace[1540422375] 'range keys from in-memory index tree'  (duration: 697.521665ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:51:09.383769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"836.071707ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14208186177166120048 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:1743 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-09T12:51:09.384376Z","caller":"traceutil/trace.go:171","msg":"trace[1559020554] linearizableReadLoop","detail":"{readStateIndex:1880; appliedIndex:1879; }","duration":"934.699661ms","start":"2026-05-09T12:51:08.449654Z","end":"2026-05-09T12:51:09.384354Z","steps":["trace[1559020554] 'read index received'  (duration: 97.940778ms)","trace[1559020554] 'applied index is now lower than readState.Index'  (duration: 836.756853ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:51:09.384538Z","caller":"traceutil/trace.go:171","msg":"trace[1119095761] transaction","detail":"{read_only:false; response_revision:1813; number_of_response:1; }","duration":"989.115468ms","start":"2026-05-09T12:51:08.395397Z","end":"2026-05-09T12:51:09.384513Z","steps":["trace[1119095761] 'process raft request'  (duration: 152.214452ms)","trace[1119095761] 'compare'  (duration: 835.74408ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T12:51:09.384714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"905.049501ms","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-05-09T12:51:09.384769Z","caller":"traceutil/trace.go:171","msg":"trace[866921022] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1813; }","duration":"905.175235ms","start":"2026-05-09T12:51:08.479581Z","end":"2026-05-09T12:51:09.384756Z","steps":["trace[866921022] 'agreement among raft nodes before linearized reading'  (duration: 905.051662ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:51:09.384847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:51:08.479561Z","time spent":"905.268908ms","remote":"127.0.0.1:52836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-05-09T12:51:09.385136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.132005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6cb82a07-c2ab-44d3-8c48-277579decfe2\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-05-09T12:51:09.385213Z","caller":"traceutil/trace.go:171","msg":"trace[1241456696] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6cb82a07-c2ab-44d3-8c48-277579decfe2; range_end:; response_count:1; response_revision:1813; }","duration":"445.243916ms","start":"2026-05-09T12:51:08.939951Z","end":"2026-05-09T12:51:09.385195Z","steps":["trace[1241456696] 'agreement among raft nodes before linearized reading'  (duration: 444.987181ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:51:09.385277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.030592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-05-09T12:51:09.385345Z","caller":"traceutil/trace.go:171","msg":"trace[1094479346] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1813; }","duration":"286.142984ms","start":"2026-05-09T12:51:09.099183Z","end":"2026-05-09T12:51:09.385326Z","steps":["trace[1094479346] 'agreement among raft nodes before linearized reading'  (duration: 285.927899ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:51:09.385412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"731.597202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T12:51:09.385438Z","caller":"traceutil/trace.go:171","msg":"trace[538646695] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1813; }","duration":"731.665953ms","start":"2026-05-09T12:51:08.653764Z","end":"2026-05-09T12:51:09.38543Z","steps":["trace[538646695] 'agreement among raft nodes before linearized reading'  (duration: 731.628932ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:51:09.385484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:51:08.653744Z","time spent":"731.721824ms","remote":"127.0.0.1:36546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-09T12:51:09.385481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.272358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6cb82a07-c2ab-44d3-8c48-277579decfe2\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-05-09T12:51:09.385983Z","caller":"traceutil/trace.go:171","msg":"trace[1605219112] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6cb82a07-c2ab-44d3-8c48-277579decfe2; range_end:; response_count:1; response_revision:1813; }","duration":"349.773989ms","start":"2026-05-09T12:51:09.036172Z","end":"2026-05-09T12:51:09.385946Z","steps":["trace[1605219112] 'agreement among raft nodes before linearized reading'  (duration: 349.123734ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:51:09.386112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:51:09.036155Z","time spent":"349.921993ms","remote":"127.0.0.1:36744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3651,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6cb82a07-c2ab-44d3-8c48-277579decfe2\" "}
{"level":"warn","ts":"2026-05-09T12:51:09.385337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:51:08.939935Z","time spent":"445.38651ms","remote":"127.0.0.1:36744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3651,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6cb82a07-c2ab-44d3-8c48-277579decfe2\" "}
{"level":"warn","ts":"2026-05-09T12:51:09.385251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"935.59508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-09T12:51:09.386701Z","caller":"traceutil/trace.go:171","msg":"trace[1346823288] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1813; }","duration":"937.073494ms","start":"2026-05-09T12:51:08.449618Z","end":"2026-05-09T12:51:09.386692Z","steps":["trace[1346823288] 'agreement among raft nodes before linearized reading'  (duration: 935.58123ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:51:09.386773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:51:08.449604Z","time spent":"937.138025ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-09T12:51:09.385461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"783.88709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-09T12:51:09.387034Z","caller":"traceutil/trace.go:171","msg":"trace[728332191] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1813; }","duration":"785.533158ms","start":"2026-05-09T12:51:08.60149Z","end":"2026-05-09T12:51:09.387023Z","steps":["trace[728332191] 'agreement among raft nodes before linearized reading'  (duration: 783.679636ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:51:09.387121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:51:08.601471Z","time spent":"785.601019ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-09T12:51:09.384743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:51:08.395382Z","time spent":"989.255671ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:1743 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-05-09T12:51:09.38554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"784.075085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-05-09T12:51:09.387327Z","caller":"traceutil/trace.go:171","msg":"trace[2009220780] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1813; }","duration":"785.840215ms","start":"2026-05-09T12:51:08.601405Z","end":"2026-05-09T12:51:09.387245Z","steps":["trace[2009220780] 'agreement among raft nodes before linearized reading'  (duration: 784.021324ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:51:09.385666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"792.802622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-05-09T12:51:09.387449Z","caller":"traceutil/trace.go:171","msg":"trace[1569287611] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1813; }","duration":"794.614392ms","start":"2026-05-09T12:51:08.592818Z","end":"2026-05-09T12:51:09.387432Z","steps":["trace[1569287611] 'agreement among raft nodes before linearized reading'  (duration: 792.70721ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:51:09.38753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:51:08.592792Z","time spent":"794.726974ms","remote":"127.0.0.1:36842","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-05-09T12:51:09.387386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:51:08.601382Z","time spent":"785.987558ms","remote":"127.0.0.1:36842","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":"info","ts":"2026-05-09T12:51:09.633093Z","caller":"traceutil/trace.go:171","msg":"trace[1893660577] transaction","detail":"{read_only:false; response_revision:1815; number_of_response:1; }","duration":"240.647157ms","start":"2026-05-09T12:51:09.392409Z","end":"2026-05-09T12:51:09.633056Z","steps":["trace[1893660577] 'process raft request'  (duration: 206.971253ms)","trace[1893660577] 'compare'  (duration: 33.366917ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:51:09.633485Z","caller":"traceutil/trace.go:171","msg":"trace[1200756177] transaction","detail":"{read_only:false; response_revision:1817; number_of_response:1; }","duration":"240.682397ms","start":"2026-05-09T12:51:09.392789Z","end":"2026-05-09T12:51:09.633471Z","steps":["trace[1200756177] 'process raft request'  (duration: 240.288598ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:51:09.633917Z","caller":"traceutil/trace.go:171","msg":"trace[996290997] transaction","detail":"{read_only:false; response_revision:1818; number_of_response:1; }","duration":"240.092855ms","start":"2026-05-09T12:51:09.393769Z","end":"2026-05-09T12:51:09.633862Z","steps":["trace[996290997] 'process raft request'  (duration: 239.650485ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:51:09.633154Z","caller":"traceutil/trace.go:171","msg":"trace[1767823366] transaction","detail":"{read_only:false; response_revision:1816; number_of_response:1; }","duration":"240.698668ms","start":"2026-05-09T12:51:09.392408Z","end":"2026-05-09T12:51:09.633107Z","steps":["trace[1767823366] 'process raft request'  (duration: 240.550135ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:51:09.709302Z","caller":"traceutil/trace.go:171","msg":"trace[402317052] linearizableReadLoop","detail":"{readStateIndex:1886; appliedIndex:1881; }","duration":"244.454112ms","start":"2026-05-09T12:51:09.464821Z","end":"2026-05-09T12:51:09.709275Z","steps":["trace[402317052] 'read index received'  (duration: 134.566992ms)","trace[402317052] 'applied index is now lower than readState.Index'  (duration: 109.88625ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:51:09.709359Z","caller":"traceutil/trace.go:171","msg":"trace[466659751] transaction","detail":"{read_only:false; response_revision:1819; number_of_response:1; }","duration":"275.701542ms","start":"2026-05-09T12:51:09.433614Z","end":"2026-05-09T12:51:09.709316Z","steps":["trace[466659751] 'process raft request'  (duration: 275.518048ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:51:09.709596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.757598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-05-09T12:51:09.709638Z","caller":"traceutil/trace.go:171","msg":"trace[1768549785] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1819; }","duration":"244.86673ms","start":"2026-05-09T12:51:09.464761Z","end":"2026-05-09T12:51:09.709628Z","steps":["trace[1768549785] 'agreement among raft nodes before linearized reading'  (duration: 244.642936ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:51:09.987686Z","caller":"traceutil/trace.go:171","msg":"trace[1377107325] transaction","detail":"{read_only:false; response_revision:1820; number_of_response:1; }","duration":"272.670204ms","start":"2026-05-09T12:51:09.714968Z","end":"2026-05-09T12:51:09.987638Z","steps":["trace[1377107325] 'process raft request'  (duration: 205.06686ms)","trace[1377107325] 'compare'  (duration: 67.258996ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:51:09.987954Z","caller":"traceutil/trace.go:171","msg":"trace[1732091658] linearizableReadLoop","detail":"{readStateIndex:1887; appliedIndex:1886; }","duration":"224.25347ms","start":"2026-05-09T12:51:09.763683Z","end":"2026-05-09T12:51:09.987936Z","steps":["trace[1732091658] 'read index received'  (duration: 156.312379ms)","trace[1732091658] 'applied index is now lower than readState.Index'  (duration: 67.940311ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T12:51:09.988126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.433953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T12:51:09.988155Z","caller":"traceutil/trace.go:171","msg":"trace[1225069881] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1822; }","duration":"224.522275ms","start":"2026-05-09T12:51:09.763625Z","end":"2026-05-09T12:51:09.988148Z","steps":["trace[1225069881] 'agreement among raft nodes before linearized reading'  (duration: 224.455454ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:51:09.988181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.022576ms","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-05-09T12:51:09.988233Z","caller":"traceutil/trace.go:171","msg":"trace[546006890] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1822; }","duration":"149.145959ms","start":"2026-05-09T12:51:09.839073Z","end":"2026-05-09T12:51:09.988219Z","steps":["trace[546006890] 'agreement among raft nodes before linearized reading'  (duration: 149.042276ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:51:17.208576Z","caller":"traceutil/trace.go:171","msg":"trace[1890440406] transaction","detail":"{read_only:false; response_revision:1895; number_of_response:1; }","duration":"115.749094ms","start":"2026-05-09T12:51:17.092803Z","end":"2026-05-09T12:51:17.208552Z","steps":["trace[1890440406] 'process raft request'  (duration: 115.56056ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:51:17.219217Z","caller":"traceutil/trace.go:171","msg":"trace[1273515048] transaction","detail":"{read_only:false; response_revision:1896; number_of_response:1; }","duration":"112.74338ms","start":"2026-05-09T12:51:17.106446Z","end":"2026-05-09T12:51:17.219189Z","steps":["trace[1273515048] 'process raft request'  (duration: 112.568437ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:51:17.529961Z","caller":"traceutil/trace.go:171","msg":"trace[1746470909] transaction","detail":"{read_only:false; response_revision:1897; number_of_response:1; }","duration":"115.927778ms","start":"2026-05-09T12:51:17.414009Z","end":"2026-05-09T12:51:17.529936Z","steps":["trace[1746470909] 'process raft request'  (duration: 115.481188ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:51:22.571454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.848694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T12:51:22.571538Z","caller":"traceutil/trace.go:171","msg":"trace[36479488] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:1930; }","duration":"222.956206ms","start":"2026-05-09T12:51:22.348555Z","end":"2026-05-09T12:51:22.571512Z","steps":["trace[36479488] 'range keys from in-memory index tree'  (duration: 222.783193ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:51:37.552296Z","caller":"traceutil/trace.go:171","msg":"trace[991723410] transaction","detail":"{read_only:false; response_revision:2025; number_of_response:1; }","duration":"204.788262ms","start":"2026-05-09T12:51:37.347479Z","end":"2026-05-09T12:51:37.552267Z","steps":["trace[991723410] 'process raft request'  (duration: 204.607647ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:51:44.101783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.317894ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14208186177166120605 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:2048 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-09T12:51:44.101892Z","caller":"traceutil/trace.go:171","msg":"trace[1956516760] linearizableReadLoop","detail":"{readStateIndex:2134; appliedIndex:2133; }","duration":"265.649212ms","start":"2026-05-09T12:51:43.836227Z","end":"2026-05-09T12:51:44.101876Z","steps":["trace[1956516760] 'read index received'  (duration: 44.087783ms)","trace[1956516760] 'applied index is now lower than readState.Index'  (duration: 221.560409ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T12:51:44.102256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.068257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-09T12:51:44.102336Z","caller":"traceutil/trace.go:171","msg":"trace[1605648755] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2060; }","duration":"261.181022ms","start":"2026-05-09T12:51:43.841135Z","end":"2026-05-09T12:51:44.102316Z","steps":["trace[1605648755] 'agreement among raft nodes before linearized reading'  (duration: 260.965577ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:51:44.102358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.389155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-05-09T12:51:44.10237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.144862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-05-09T12:51:44.102403Z","caller":"traceutil/trace.go:171","msg":"trace[1319069817] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:2060; }","duration":"227.468006ms","start":"2026-05-09T12:51:43.874923Z","end":"2026-05-09T12:51:44.102391Z","steps":["trace[1319069817] 'agreement among raft nodes before linearized reading'  (duration: 227.393345ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:51:44.102407Z","caller":"traceutil/trace.go:171","msg":"trace[1939461698] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2060; }","duration":"266.220483ms","start":"2026-05-09T12:51:43.836176Z","end":"2026-05-09T12:51:44.102397Z","steps":["trace[1939461698] 'agreement among raft nodes before linearized reading'  (duration: 266.06887ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:51:44.102521Z","caller":"traceutil/trace.go:171","msg":"trace[1228106648] transaction","detail":"{read_only:false; response_revision:2060; number_of_response:1; }","duration":"266.950596ms","start":"2026-05-09T12:51:43.83556Z","end":"2026-05-09T12:51:44.10251Z","steps":["trace[1228106648] 'process raft request'  (duration: 44.822757ms)","trace[1228106648] 'compare'  (duration: 221.14254ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T12:51:44.10351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.836213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-05-09T12:51:44.103557Z","caller":"traceutil/trace.go:171","msg":"trace[1454148855] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2060; }","duration":"261.908353ms","start":"2026-05-09T12:51:43.841638Z","end":"2026-05-09T12:51:44.103547Z","steps":["trace[1454148855] 'agreement among raft nodes before linearized reading'  (duration: 260.808224ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:51:44.513667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.990855ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14208186177166120608 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2052 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-09T12:51:44.513802Z","caller":"traceutil/trace.go:171","msg":"trace[1286980922] transaction","detail":"{read_only:false; response_revision:2061; number_of_response:1; }","duration":"408.506566ms","start":"2026-05-09T12:51:44.105273Z","end":"2026-05-09T12:51:44.513779Z","steps":["trace[1286980922] 'process raft request'  (duration: 272.320107ms)","trace[1286980922] 'compare'  (duration: 135.866893ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T12:51:44.51388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:51:44.105245Z","time spent":"408.597707ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2052 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-09T12:51:44.961002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.377551ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14208186177166120609 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2049 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-09T12:51:44.961457Z","caller":"traceutil/trace.go:171","msg":"trace[1636523267] linearizableReadLoop","detail":"{readStateIndex:2138; appliedIndex:2134; }","duration":"821.963422ms","start":"2026-05-09T12:51:44.13947Z","end":"2026-05-09T12:51:44.961434Z","steps":["trace[1636523267] 'read index received'  (duration: 238.111267ms)","trace[1636523267] 'applied index is now lower than readState.Index'  (duration: 583.851045ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:51:44.961483Z","caller":"traceutil/trace.go:171","msg":"trace[448958388] transaction","detail":"{read_only:false; response_revision:2063; number_of_response:1; }","duration":"855.184494ms","start":"2026-05-09T12:51:44.106267Z","end":"2026-05-09T12:51:44.961451Z","steps":["trace[448958388] 'process raft request'  (duration: 854.97987ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:51:44.961697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:51:44.106247Z","time spent":"855.369898ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:2050 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-05-09T12:51:44.961503Z","caller":"traceutil/trace.go:171","msg":"trace[535192047] transaction","detail":"{read_only:false; response_revision:2064; number_of_response:1; }","duration":"853.972542ms","start":"2026-05-09T12:51:44.10751Z","end":"2026-05-09T12:51:44.961483Z","steps":["trace[535192047] 'process raft request'  (duration: 853.87086ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:51:44.961903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:51:44.107503Z","time spent":"854.341449ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:2051 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-05-09T12:51:44.96192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"822.413129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-05-09T12:51:44.961494Z","caller":"traceutil/trace.go:171","msg":"trace[1295219338] transaction","detail":"{read_only:false; response_revision:2062; number_of_response:1; }","duration":"855.214565ms","start":"2026-05-09T12:51:44.106184Z","end":"2026-05-09T12:51:44.961398Z","steps":["trace[1295219338] 'process raft request'  (duration: 669.350925ms)","trace[1295219338] 'compare'  (duration: 185.223349ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T12:51:44.962015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:51:44.106167Z","time spent":"855.816745ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2049 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-05-09T12:51:44.961999Z","caller":"traceutil/trace.go:171","msg":"trace[825793605] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2064; }","duration":"822.508891ms","start":"2026-05-09T12:51:44.139455Z","end":"2026-05-09T12:51:44.961964Z","steps":["trace[825793605] 'agreement among raft nodes before linearized reading'  (duration: 822.078494ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:51:44.962069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:51:44.139394Z","time spent":"822.663345ms","remote":"127.0.0.1:36842","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-05-09T12:51:44.962211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.733714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-05-09T12:51:44.962257Z","caller":"traceutil/trace.go:171","msg":"trace[449860168] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2064; }","duration":"246.819486ms","start":"2026-05-09T12:51:44.715422Z","end":"2026-05-09T12:51:44.962242Z","steps":["trace[449860168] 'agreement among raft nodes before linearized reading'  (duration: 246.668203ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:51:44.962345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.995138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-09T12:51:44.962419Z","caller":"traceutil/trace.go:171","msg":"trace[2130449575] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:2064; }","duration":"231.15543ms","start":"2026-05-09T12:51:44.731251Z","end":"2026-05-09T12:51:44.962406Z","steps":["trace[2130449575] 'agreement among raft nodes before linearized reading'  (duration: 231.010008ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:51:44.962402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.989822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T12:51:44.962654Z","caller":"traceutil/trace.go:171","msg":"trace[2101601251] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2064; }","duration":"309.230865ms","start":"2026-05-09T12:51:44.653359Z","end":"2026-05-09T12:51:44.96259Z","steps":["trace[2101601251] 'agreement among raft nodes before linearized reading'  (duration: 308.88752ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:51:44.962885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:51:44.653337Z","time spent":"309.533002ms","remote":"127.0.0.1:36540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-09T12:51:44.96317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.137758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-05-09T12:51:44.963283Z","caller":"traceutil/trace.go:171","msg":"trace[187064768] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2064; }","duration":"585.303562ms","start":"2026-05-09T12:51:44.377958Z","end":"2026-05-09T12:51:44.963262Z","steps":["trace[187064768] 'agreement among raft nodes before linearized reading'  (duration: 584.07895ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:51:44.963393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:51:44.377932Z","time spent":"585.446294ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-05-09T12:51:45.466605Z","caller":"traceutil/trace.go:171","msg":"trace[9414349] transaction","detail":"{read_only:false; response_revision:2066; number_of_response:1; }","duration":"497.63498ms","start":"2026-05-09T12:51:44.968939Z","end":"2026-05-09T12:51:45.466574Z","steps":["trace[9414349] 'process raft request'  (duration: 496.121723ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:51:45.46704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:51:44.96893Z","time spent":"498.025097ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2055 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-09T12:52:48.823751Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186177166121650,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-05-09T12:52:49.035364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.568142ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-09T12:52:49.035467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.079828342s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-09T12:52:49.035516Z","caller":"traceutil/trace.go:171","msg":"trace[430996688] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2507; }","duration":"1.079940872s","start":"2026-05-09T12:52:47.955562Z","end":"2026-05-09T12:52:49.035502Z","steps":["trace[430996688] 'range keys from in-memory index tree'  (duration: 1.079496125s)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:52:49.035517Z","caller":"traceutil/trace.go:171","msg":"trace[1805228733] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2507; }","duration":"349.750535ms","start":"2026-05-09T12:52:48.685745Z","end":"2026-05-09T12:52:49.035495Z","steps":["trace[1805228733] 'range keys from in-memory index tree'  (duration: 349.543502ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:52:49.03554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:52:47.955529Z","time spent":"1.080006354s","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-05-09T12:52:49.035715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"915.622865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"}
{"level":"info","ts":"2026-05-09T12:52:49.035802Z","caller":"traceutil/trace.go:171","msg":"trace[1979611930] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2507; }","duration":"915.705837ms","start":"2026-05-09T12:52:48.120055Z","end":"2026-05-09T12:52:49.035761Z","steps":["trace[1979611930] 'range keys from in-memory index tree'  (duration: 915.518634ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:52:49.035848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:52:48.12004Z","time spent":"915.799918ms","remote":"127.0.0.1:36758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1393,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "}
{"level":"info","ts":"2026-05-09T12:52:49.036316Z","caller":"traceutil/trace.go:171","msg":"trace[1559644823] transaction","detail":"{read_only:false; response_revision:2508; number_of_response:1; }","duration":"714.573979ms","start":"2026-05-09T12:52:48.321728Z","end":"2026-05-09T12:52:49.036302Z","steps":["trace[1559644823] 'process raft request'  (duration: 714.446187ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:52:49.036422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:52:48.321705Z","time spent":"714.656751ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:2495 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-09T12:52:49.039176Z","caller":"traceutil/trace.go:171","msg":"trace[1989179374] linearizableReadLoop","detail":"{readStateIndex:2598; appliedIndex:2597; }","duration":"716.516168ms","start":"2026-05-09T12:52:48.32263Z","end":"2026-05-09T12:52:49.039146Z","steps":["trace[1989179374] 'read index received'  (duration: 714.045172ms)","trace[1989179374] 'applied index is now lower than readState.Index'  (duration: 2.469926ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T12:52:49.039298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"716.656549ms","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-05-09T12:52:49.039336Z","caller":"traceutil/trace.go:171","msg":"trace[1646722845] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:2509; }","duration":"716.73024ms","start":"2026-05-09T12:52:48.322594Z","end":"2026-05-09T12:52:49.039324Z","steps":["trace[1646722845] 'agreement among raft nodes before linearized reading'  (duration: 716.661409ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:52:49.03939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:52:48.322578Z","time spent":"716.801881ms","remote":"127.0.0.1:36796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":29,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "}
{"level":"warn","ts":"2026-05-09T12:52:49.039463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.214419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T12:52:49.039533Z","caller":"traceutil/trace.go:171","msg":"trace[1711137978] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2509; }","duration":"383.31819ms","start":"2026-05-09T12:52:48.656197Z","end":"2026-05-09T12:52:49.039516Z","steps":["trace[1711137978] 'agreement among raft nodes before linearized reading'  (duration: 383.189628ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:52:49.039322Z","caller":"traceutil/trace.go:171","msg":"trace[2086146992] transaction","detail":"{read_only:false; response_revision:2509; number_of_response:1; }","duration":"273.381342ms","start":"2026-05-09T12:52:48.765845Z","end":"2026-05-09T12:52:49.039227Z","steps":["trace[2086146992] 'process raft request'  (duration: 273.185839ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:52:49.039575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:52:48.656177Z","time spent":"383.38992ms","remote":"127.0.0.1:36540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-09T12:52:49.039607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.433514ms","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-05-09T12:52:49.039668Z","caller":"traceutil/trace.go:171","msg":"trace[893642329] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2509; }","duration":"240.563686ms","start":"2026-05-09T12:52:48.799087Z","end":"2026-05-09T12:52:49.039651Z","steps":["trace[893642329] 'agreement among raft nodes before linearized reading'  (duration: 240.339102ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:52:53.160161Z","caller":"traceutil/trace.go:171","msg":"trace[1992153148] transaction","detail":"{read_only:false; response_revision:2529; number_of_response:1; }","duration":"108.153296ms","start":"2026-05-09T12:52:53.051982Z","end":"2026-05-09T12:52:53.160135Z","steps":["trace[1992153148] 'process raft request'  (duration: 107.966503ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:52:53.210545Z","caller":"traceutil/trace.go:171","msg":"trace[1385793680] linearizableReadLoop","detail":"{readStateIndex:2620; appliedIndex:2618; }","duration":"155.805527ms","start":"2026-05-09T12:52:53.054698Z","end":"2026-05-09T12:52:53.210504Z","steps":["trace[1385793680] 'read index received'  (duration: 105.315945ms)","trace[1385793680] 'applied index is now lower than readState.Index'  (duration: 50.487512ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:52:53.210614Z","caller":"traceutil/trace.go:171","msg":"trace[44115296] transaction","detail":"{read_only:false; response_revision:2530; number_of_response:1; }","duration":"157.908337ms","start":"2026-05-09T12:52:53.05267Z","end":"2026-05-09T12:52:53.210578Z","steps":["trace[44115296] 'process raft request'  (duration: 135.854942ms)","trace[44115296] 'compare'  (duration: 21.789352ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T12:52:53.210762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.051951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-05-09T12:52:53.210811Z","caller":"traceutil/trace.go:171","msg":"trace[1526813526] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2530; }","duration":"156.134662ms","start":"2026-05-09T12:52:53.054665Z","end":"2026-05-09T12:52:53.2108Z","steps":["trace[1526813526] 'agreement among raft nodes before linearized reading'  (duration: 156.024189ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:53:26.393748Z","caller":"traceutil/trace.go:171","msg":"trace[148173015] linearizableReadLoop","detail":"{readStateIndex:2812; appliedIndex:2811; }","duration":"272.636821ms","start":"2026-05-09T12:53:26.121074Z","end":"2026-05-09T12:53:26.393711Z","steps":["trace[148173015] 'read index received'  (duration: 192.271485ms)","trace[148173015] 'applied index is now lower than readState.Index'  (duration: 80.363956ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:53:26.393796Z","caller":"traceutil/trace.go:171","msg":"trace[1233211044] transaction","detail":"{read_only:false; response_revision:2715; number_of_response:1; }","duration":"303.816903ms","start":"2026-05-09T12:53:26.089931Z","end":"2026-05-09T12:53:26.393748Z","steps":["trace[1233211044] 'process raft request'  (duration: 223.497928ms)","trace[1233211044] 'compare'  (duration: 80.120483ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T12:53:26.393992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:53:26.089904Z","time spent":"303.979695ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2705 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:463 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-09T12:53:26.394021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.398416ms","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-05-09T12:53:26.394114Z","caller":"traceutil/trace.go:171","msg":"trace[1308054636] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:2715; }","duration":"203.54058ms","start":"2026-05-09T12:53:26.19055Z","end":"2026-05-09T12:53:26.39409Z","steps":["trace[1308054636] 'agreement among raft nodes before linearized reading'  (duration: 203.381987ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:53:26.394033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.945145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"}
{"level":"info","ts":"2026-05-09T12:53:26.394395Z","caller":"traceutil/trace.go:171","msg":"trace[478761848] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2715; }","duration":"273.377983ms","start":"2026-05-09T12:53:26.120963Z","end":"2026-05-09T12:53:26.394341Z","steps":["trace[478761848] 'agreement among raft nodes before linearized reading'  (duration: 272.850655ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:54:40.097282Z","caller":"traceutil/trace.go:171","msg":"trace[559254970] transaction","detail":"{read_only:false; response_revision:3104; number_of_response:1; }","duration":"106.229341ms","start":"2026-05-09T12:54:39.991032Z","end":"2026-05-09T12:54:40.097262Z","steps":["trace[559254970] 'process raft request'  (duration: 91.171141ms)","trace[559254970] 'compare'  (duration: 14.966027ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:54:40.57365Z","caller":"traceutil/trace.go:171","msg":"trace[1804227287] transaction","detail":"{read_only:false; response_revision:3105; number_of_response:1; }","duration":"135.146854ms","start":"2026-05-09T12:54:40.438484Z","end":"2026-05-09T12:54:40.57363Z","steps":["trace[1804227287] 'process raft request'  (duration: 135.02473ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:55:14.350393Z","caller":"traceutil/trace.go:171","msg":"trace[118482036] linearizableReadLoop","detail":"{readStateIndex:3485; appliedIndex:3484; }","duration":"107.179801ms","start":"2026-05-09T12:55:14.243191Z","end":"2026-05-09T12:55:14.350371Z","steps":["trace[118482036] 'read index received'  (duration: 98.202437ms)","trace[118482036] 'applied index is now lower than readState.Index'  (duration: 8.976344ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:55:14.350411Z","caller":"traceutil/trace.go:171","msg":"trace[543803710] transaction","detail":"{read_only:false; response_revision:3361; number_of_response:1; }","duration":"107.711379ms","start":"2026-05-09T12:55:14.24267Z","end":"2026-05-09T12:55:14.350382Z","steps":["trace[543803710] 'process raft request'  (duration: 98.685433ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:55:14.350538Z","caller":"traceutil/trace.go:171","msg":"trace[705440091] transaction","detail":"{read_only:false; response_revision:3362; number_of_response:1; }","duration":"105.382345ms","start":"2026-05-09T12:55:14.245128Z","end":"2026-05-09T12:55:14.35051Z","steps":["trace[705440091] 'process raft request'  (duration: 105.192789ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:55:14.350717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.513101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-05-09T12:55:14.351421Z","caller":"traceutil/trace.go:171","msg":"trace[1346029741] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3362; }","duration":"108.250665ms","start":"2026-05-09T12:55:14.243154Z","end":"2026-05-09T12:55:14.351405Z","steps":["trace[1346029741] 'agreement among raft nodes before linearized reading'  (duration: 107.341106ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:55:28.016125Z","caller":"traceutil/trace.go:171","msg":"trace[1818971626] transaction","detail":"{read_only:false; response_revision:3439; number_of_response:1; }","duration":"124.751453ms","start":"2026-05-09T12:55:27.89135Z","end":"2026-05-09T12:55:28.016101Z","steps":["trace[1818971626] 'process raft request'  (duration: 116.96818ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:55:30.735418Z","caller":"traceutil/trace.go:171","msg":"trace[254192198] transaction","detail":"{read_only:false; response_revision:3457; number_of_response:1; }","duration":"148.772559ms","start":"2026-05-09T12:55:30.586589Z","end":"2026-05-09T12:55:30.735361Z","steps":["trace[254192198] 'process raft request'  (duration: 60.968405ms)","trace[254192198] 'compare'  (duration: 87.155174ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:55:32.088344Z","caller":"traceutil/trace.go:171","msg":"trace[702479764] transaction","detail":"{read_only:false; response_revision:3461; number_of_response:1; }","duration":"100.546043ms","start":"2026-05-09T12:55:31.987772Z","end":"2026-05-09T12:55:32.088318Z","steps":["trace[702479764] 'process raft request'  (duration: 100.349337ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:55:32.351873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.143703ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14208186177166124303 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:3452 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-09T12:55:32.352638Z","caller":"traceutil/trace.go:171","msg":"trace[323901088] linearizableReadLoop","detail":"{readStateIndex:3589; appliedIndex:3588; }","duration":"205.959056ms","start":"2026-05-09T12:55:32.146653Z","end":"2026-05-09T12:55:32.352612Z","steps":["trace[323901088] 'read index received'  (duration: 7.876194ms)","trace[323901088] 'applied index is now lower than readState.Index'  (duration: 198.080492ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T12:55:32.352894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.225704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-05-09T12:55:32.352966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.548757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-09T12:55:32.352915Z","caller":"traceutil/trace.go:171","msg":"trace[69680075] transaction","detail":"{read_only:false; response_revision:3462; number_of_response:1; }","duration":"301.104775ms","start":"2026-05-09T12:55:32.051754Z","end":"2026-05-09T12:55:32.352858Z","steps":["trace[69680075] 'process raft request'  (duration: 102.769176ms)","trace[69680075] 'compare'  (duration: 197.01568ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T12:55:32.353127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:55:32.051739Z","time spent":"301.277731ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:3452 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-09T12:55:32.353143Z","caller":"traceutil/trace.go:171","msg":"trace[112661976] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:3462; }","duration":"206.339537ms","start":"2026-05-09T12:55:32.146647Z","end":"2026-05-09T12:55:32.352986Z","steps":["trace[112661976] 'agreement among raft nodes before linearized reading'  (duration: 206.196253ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:55:32.353254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.406247ms","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-05-09T12:55:32.353373Z","caller":"traceutil/trace.go:171","msg":"trace[350391651] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3462; }","duration":"141.533842ms","start":"2026-05-09T12:55:32.211813Z","end":"2026-05-09T12:55:32.353347Z","steps":["trace[350391651] 'agreement among raft nodes before linearized reading'  (duration: 141.124399ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:55:32.353179Z","caller":"traceutil/trace.go:171","msg":"trace[218957808] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3462; }","duration":"172.64719ms","start":"2026-05-09T12:55:32.180354Z","end":"2026-05-09T12:55:32.353001Z","steps":["trace[218957808] 'agreement among raft nodes before linearized reading'  (duration: 172.518347ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:55:49.015387Z","caller":"traceutil/trace.go:171","msg":"trace[1393831342] transaction","detail":"{read_only:false; response_revision:3553; number_of_response:1; }","duration":"173.915572ms","start":"2026-05-09T12:55:48.841444Z","end":"2026-05-09T12:55:49.015359Z","steps":["trace[1393831342] 'process raft request'  (duration: 94.95951ms)","trace[1393831342] 'compare'  (duration: 78.760977ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:55:49.015508Z","caller":"traceutil/trace.go:171","msg":"trace[169204686] transaction","detail":"{read_only:false; response_revision:3554; number_of_response:1; }","duration":"116.428459ms","start":"2026-05-09T12:55:48.899053Z","end":"2026-05-09T12:55:49.015482Z","steps":["trace[169204686] 'process raft request'  (duration: 116.273345ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:55:49.318695Z","caller":"traceutil/trace.go:171","msg":"trace[1122433367] transaction","detail":"{read_only:false; response_revision:3555; number_of_response:1; }","duration":"106.917943ms","start":"2026-05-09T12:55:49.211755Z","end":"2026-05-09T12:55:49.318673Z","steps":["trace[1122433367] 'process raft request'  (duration: 106.79634ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:55:49.527401Z","caller":"traceutil/trace.go:171","msg":"trace[857025683] transaction","detail":"{read_only:false; response_revision:3556; number_of_response:1; }","duration":"202.950165ms","start":"2026-05-09T12:55:49.324407Z","end":"2026-05-09T12:55:49.527357Z","steps":["trace[857025683] 'process raft request'  (duration: 142.00005ms)","trace[857025683] 'compare'  (duration: 60.747489ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:56:33.451044Z","caller":"traceutil/trace.go:171","msg":"trace[844331556] linearizableReadLoop","detail":"{readStateIndex:4010; appliedIndex:4008; }","duration":"118.861037ms","start":"2026-05-09T12:56:33.332165Z","end":"2026-05-09T12:56:33.451026Z","steps":["trace[844331556] 'read index received'  (duration: 80.175928ms)","trace[844331556] 'applied index is now lower than readState.Index'  (duration: 38.684459ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:56:33.45118Z","caller":"traceutil/trace.go:171","msg":"trace[2135064932] transaction","detail":"{read_only:false; response_revision:3864; number_of_response:1; }","duration":"159.858092ms","start":"2026-05-09T12:56:33.291271Z","end":"2026-05-09T12:56:33.451129Z","steps":["trace[2135064932] 'process raft request'  (duration: 121.06844ms)","trace[2135064932] 'compare'  (duration: 38.305311ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:56:33.451357Z","caller":"traceutil/trace.go:171","msg":"trace[1397337973] transaction","detail":"{read_only:false; response_revision:3865; number_of_response:1; }","duration":"157.831214ms","start":"2026-05-09T12:56:33.293503Z","end":"2026-05-09T12:56:33.451334Z","steps":["trace[1397337973] 'process raft request'  (duration: 157.468524ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:56:33.451764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.588924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-05-09T12:56:33.451848Z","caller":"traceutil/trace.go:171","msg":"trace[846455895] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3865; }","duration":"119.691107ms","start":"2026-05-09T12:56:33.332121Z","end":"2026-05-09T12:56:33.451812Z","steps":["trace[846455895] 'agreement among raft nodes before linearized reading'  (duration: 118.983629ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:56:36.821349Z","caller":"traceutil/trace.go:171","msg":"trace[204738646] transaction","detail":"{read_only:false; response_revision:3882; number_of_response:1; }","duration":"112.434938ms","start":"2026-05-09T12:56:36.708889Z","end":"2026-05-09T12:56:36.821324Z","steps":["trace[204738646] 'process raft request'  (duration: 112.245783ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:56:37.542198Z","caller":"traceutil/trace.go:171","msg":"trace[663672052] transaction","detail":"{read_only:false; response_revision:3888; number_of_response:1; }","duration":"235.22308ms","start":"2026-05-09T12:56:37.30695Z","end":"2026-05-09T12:56:37.542173Z","steps":["trace[663672052] 'process raft request'  (duration: 235.098677ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:56:37.657414Z","caller":"traceutil/trace.go:171","msg":"trace[1929346939] linearizableReadLoop","detail":"{readStateIndex:4035; appliedIndex:4033; }","duration":"178.57221ms","start":"2026-05-09T12:56:37.478819Z","end":"2026-05-09T12:56:37.657391Z","steps":["trace[1929346939] 'read index received'  (duration: 63.237999ms)","trace[1929346939] 'applied index is now lower than readState.Index'  (duration: 115.332771ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:56:37.657476Z","caller":"traceutil/trace.go:171","msg":"trace[617460959] transaction","detail":"{read_only:false; response_revision:3889; number_of_response:1; }","duration":"185.942117ms","start":"2026-05-09T12:56:37.471494Z","end":"2026-05-09T12:56:37.657436Z","steps":["trace[617460959] 'process raft request'  (duration: 133.584069ms)","trace[617460959] 'compare'  (duration: 52.154472ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T12:56:37.657657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.817516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-05-09T12:56:37.657732Z","caller":"traceutil/trace.go:171","msg":"trace[148388075] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3889; }","duration":"178.929518ms","start":"2026-05-09T12:56:37.478785Z","end":"2026-05-09T12:56:37.657714Z","steps":["trace[148388075] 'agreement among raft nodes before linearized reading'  (duration: 178.735714ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:57:06.063547Z","caller":"traceutil/trace.go:171","msg":"trace[1888862516] transaction","detail":"{read_only:false; response_revision:4405; number_of_response:1; }","duration":"304.42464ms","start":"2026-05-09T12:57:05.759092Z","end":"2026-05-09T12:57:06.063517Z","steps":["trace[1888862516] 'process raft request'  (duration: 299.967591ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:57:06.063764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:57:05.759071Z","time spent":"304.609645ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:4374 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-05-09T12:57:06.064803Z","caller":"traceutil/trace.go:171","msg":"trace[1797209418] linearizableReadLoop","detail":"{readStateIndex:4573; appliedIndex:4571; }","duration":"202.043148ms","start":"2026-05-09T12:57:05.862739Z","end":"2026-05-09T12:57:06.064782Z","steps":["trace[1797209418] 'read index received'  (duration: 196.421563ms)","trace[1797209418] 'applied index is now lower than readState.Index'  (duration: 5.620585ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:57:06.065229Z","caller":"traceutil/trace.go:171","msg":"trace[1859274985] transaction","detail":"{read_only:false; response_revision:4406; number_of_response:1; }","duration":"232.940281ms","start":"2026-05-09T12:57:05.83227Z","end":"2026-05-09T12:57:06.06521Z","steps":["trace[1859274985] 'process raft request'  (duration: 232.254266ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:57:06.065414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.661622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-05-09T12:57:06.065488Z","caller":"traceutil/trace.go:171","msg":"trace[821075629] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4408; }","duration":"202.786906ms","start":"2026-05-09T12:57:05.862684Z","end":"2026-05-09T12:57:06.065471Z","steps":["trace[821075629] 'agreement among raft nodes before linearized reading'  (duration: 202.554711ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:57:06.065992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.274709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" ","response":"range_response_count:1 size:9696"}
{"level":"info","ts":"2026-05-09T12:57:06.066947Z","caller":"traceutil/trace.go:171","msg":"trace[1812912065] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:1; response_revision:4408; }","duration":"146.279571ms","start":"2026-05-09T12:57:05.920658Z","end":"2026-05-09T12:57:06.066937Z","steps":["trace[1812912065] 'agreement among raft nodes before linearized reading'  (duration: 144.689016ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:57:11.197576Z","caller":"traceutil/trace.go:171","msg":"trace[134408129] transaction","detail":"{read_only:false; response_revision:4575; number_of_response:1; }","duration":"108.484555ms","start":"2026-05-09T12:57:11.089069Z","end":"2026-05-09T12:57:11.197554Z","steps":["trace[134408129] 'process raft request'  (duration: 108.316621ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:57:11.478253Z","caller":"traceutil/trace.go:171","msg":"trace[1869924224] linearizableReadLoop","detail":"{readStateIndex:4749; appliedIndex:4747; }","duration":"259.834237ms","start":"2026-05-09T12:57:11.218376Z","end":"2026-05-09T12:57:11.47821Z","steps":["trace[1869924224] 'read index received'  (duration: 207.731236ms)","trace[1869924224] 'applied index is now lower than readState.Index'  (duration: 52.101691ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:57:11.478307Z","caller":"traceutil/trace.go:171","msg":"trace[1178370518] transaction","detail":"{read_only:false; response_revision:4577; number_of_response:1; }","duration":"309.703908ms","start":"2026-05-09T12:57:11.168546Z","end":"2026-05-09T12:57:11.47825Z","steps":["trace[1178370518] 'process raft request'  (duration: 309.531833ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:57:11.478522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.130833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"warn","ts":"2026-05-09T12:57:11.478562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:57:11.168523Z","time spent":"309.912192ms","remote":"127.0.0.1:36744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11439,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" mod_revision:4426 > success:<request_put:<key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" value_size:11356 >> failure:<request_range:<key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" > >"}
{"level":"info","ts":"2026-05-09T12:57:11.478591Z","caller":"traceutil/trace.go:171","msg":"trace[2129264430] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4577; }","duration":"260.239395ms","start":"2026-05-09T12:57:11.218336Z","end":"2026-05-09T12:57:11.478575Z","steps":["trace[2129264430] 'agreement among raft nodes before linearized reading'  (duration: 260.020111ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:57:11.478617Z","caller":"traceutil/trace.go:171","msg":"trace[1997689626] transaction","detail":"{read_only:false; response_revision:4576; number_of_response:1; }","duration":"354.367403ms","start":"2026-05-09T12:57:11.124222Z","end":"2026-05-09T12:57:11.47859Z","steps":["trace[1997689626] 'process raft request'  (duration: 301.906894ms)","trace[1997689626] 'compare'  (duration: 51.768623ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T12:57:11.478778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:57:11.12418Z","time spent":"354.504506ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:4034 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-05-09T12:57:11.483937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.085377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2195929"}
{"level":"info","ts":"2026-05-09T12:57:11.484018Z","caller":"traceutil/trace.go:171","msg":"trace[1141750305] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4578; }","duration":"195.214969ms","start":"2026-05-09T12:57:11.288783Z","end":"2026-05-09T12:57:11.483998Z","steps":["trace[1141750305] 'agreement among raft nodes before linearized reading'  (duration: 193.943641ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:57:11.484384Z","caller":"traceutil/trace.go:171","msg":"trace[1836171592] transaction","detail":"{read_only:false; response_revision:4578; number_of_response:1; }","duration":"155.341899ms","start":"2026-05-09T12:57:11.329022Z","end":"2026-05-09T12:57:11.484364Z","steps":["trace[1836171592] 'process raft request'  (duration: 153.600111ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:57:11.488939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.653331ms","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-05-09T12:57:11.488992Z","caller":"traceutil/trace.go:171","msg":"trace[1777212242] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4578; }","duration":"114.732423ms","start":"2026-05-09T12:57:11.374238Z","end":"2026-05-09T12:57:11.48897Z","steps":["trace[1777212242] 'agreement among raft nodes before linearized reading'  (duration: 114.644181ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:57:12.204804Z","caller":"traceutil/trace.go:171","msg":"trace[1190051711] linearizableReadLoop","detail":"{readStateIndex:4764; appliedIndex:4763; }","duration":"109.408599ms","start":"2026-05-09T12:57:12.095372Z","end":"2026-05-09T12:57:12.20478Z","steps":["trace[1190051711] 'read index received'  (duration: 94.936552ms)","trace[1190051711] 'applied index is now lower than readState.Index'  (duration: 14.471077ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:57:12.204935Z","caller":"traceutil/trace.go:171","msg":"trace[779713009] transaction","detail":"{read_only:false; response_revision:4591; number_of_response:1; }","duration":"110.393152ms","start":"2026-05-09T12:57:12.094519Z","end":"2026-05-09T12:57:12.204912Z","steps":["trace[779713009] 'process raft request'  (duration: 95.813321ms)","trace[779713009] 'compare'  (duration: 14.332805ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T12:57:12.205042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.649095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-05-09T12:57:12.205092Z","caller":"traceutil/trace.go:171","msg":"trace[160904146] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4591; }","duration":"109.714756ms","start":"2026-05-09T12:57:12.095351Z","end":"2026-05-09T12:57:12.205066Z","steps":["trace[160904146] 'agreement among raft nodes before linearized reading'  (duration: 109.554983ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:57:12.761282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.09163ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14208186177166126892 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:4531 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:463 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-09T12:57:12.761475Z","caller":"traceutil/trace.go:171","msg":"trace[829704398] transaction","detail":"{read_only:false; response_revision:4592; number_of_response:1; }","duration":"552.434508ms","start":"2026-05-09T12:57:12.20901Z","end":"2026-05-09T12:57:12.761444Z","steps":["trace[829704398] 'process raft request'  (duration: 326.094372ms)","trace[829704398] 'compare'  (duration: 225.958727ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:57:12.76152Z","caller":"traceutil/trace.go:171","msg":"trace[1314723584] transaction","detail":"{read_only:false; response_revision:4593; number_of_response:1; }","duration":"551.536028ms","start":"2026-05-09T12:57:12.209967Z","end":"2026-05-09T12:57:12.761503Z","steps":["trace[1314723584] 'process raft request'  (duration: 551.411515ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:57:12.76159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:57:12.209939Z","time spent":"551.617719ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:4530 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-05-09T12:57:12.76162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:57:12.208992Z","time spent":"552.545771ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:4531 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:463 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-09T12:57:12.761712Z","caller":"traceutil/trace.go:171","msg":"trace[847710346] linearizableReadLoop","detail":"{readStateIndex:4766; appliedIndex:4764; }","duration":"469.45001ms","start":"2026-05-09T12:57:12.292231Z","end":"2026-05-09T12:57:12.761681Z","steps":["trace[847710346] 'read index received'  (duration: 242.887799ms)","trace[847710346] 'applied index is now lower than readState.Index'  (duration: 226.559931ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:57:12.761753Z","caller":"traceutil/trace.go:171","msg":"trace[1773174269] transaction","detail":"{read_only:false; response_revision:4594; number_of_response:1; }","duration":"454.538161ms","start":"2026-05-09T12:57:12.307204Z","end":"2026-05-09T12:57:12.761742Z","steps":["trace[1773174269] 'process raft request'  (duration: 454.259115ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:57:12.761803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:57:12.307186Z","time spent":"454.590592ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:4396 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"warn","ts":"2026-05-09T12:57:12.761887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.032357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-09T12:57:12.761934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.362748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T12:57:12.761939Z","caller":"traceutil/trace.go:171","msg":"trace[1834129658] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:4595; }","duration":"462.084848ms","start":"2026-05-09T12:57:12.299825Z","end":"2026-05-09T12:57:12.76191Z","steps":["trace[1834129658] 'agreement among raft nodes before linearized reading'  (duration: 462.016606ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:57:12.761964Z","caller":"traceutil/trace.go:171","msg":"trace[1946878506] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4595; }","duration":"109.426869ms","start":"2026-05-09T12:57:12.652528Z","end":"2026-05-09T12:57:12.761955Z","steps":["trace[1946878506] 'agreement among raft nodes before linearized reading'  (duration: 109.348668ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:57:12.761953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.704146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-srlsl\" ","response":"range_response_count:1 size:5145"}
{"level":"warn","ts":"2026-05-09T12:57:12.761974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:57:12.299819Z","time spent":"462.145629ms","remote":"127.0.0.1:43812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true "}
{"level":"info","ts":"2026-05-09T12:57:12.762004Z","caller":"traceutil/trace.go:171","msg":"trace[2094572712] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-srlsl; range_end:; response_count:1; response_revision:4595; }","duration":"469.794477ms","start":"2026-05-09T12:57:12.292196Z","end":"2026-05-09T12:57:12.76199Z","steps":["trace[2094572712] 'agreement among raft nodes before linearized reading'  (duration: 469.627134ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:57:12.762035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:57:12.29218Z","time spent":"469.848488ms","remote":"127.0.0.1:36744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":5169,"request content":"key:\"/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-srlsl\" "}
{"level":"warn","ts":"2026-05-09T12:57:12.762141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.550366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-09T12:57:12.762196Z","caller":"traceutil/trace.go:171","msg":"trace[1305666538] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:4595; }","duration":"303.655438ms","start":"2026-05-09T12:57:12.458529Z","end":"2026-05-09T12:57:12.762184Z","steps":["trace[1305666538] 'agreement among raft nodes before linearized reading'  (duration: 303.366621ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:57:12.762223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:57:12.458509Z","time spent":"303.70818ms","remote":"127.0.0.1:36620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":433,"response size":32,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "}
{"level":"info","ts":"2026-05-09T12:57:18.352306Z","caller":"traceutil/trace.go:171","msg":"trace[809824773] linearizableReadLoop","detail":"{readStateIndex:4870; appliedIndex:4868; }","duration":"452.567481ms","start":"2026-05-09T12:57:17.899716Z","end":"2026-05-09T12:57:18.352284Z","steps":["trace[809824773] 'read index received'  (duration: 20.924246ms)","trace[809824773] 'applied index is now lower than readState.Index'  (duration: 431.642105ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:57:18.353078Z","caller":"traceutil/trace.go:171","msg":"trace[994379195] transaction","detail":"{read_only:false; response_revision:4695; number_of_response:1; }","duration":"477.831812ms","start":"2026-05-09T12:57:17.875218Z","end":"2026-05-09T12:57:18.353049Z","steps":["trace[994379195] 'process raft request'  (duration: 476.905721ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:57:18.353257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:57:17.875193Z","time spent":"477.954835ms","remote":"127.0.0.1:36744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11830,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-66dc596fcb-jl9lm\" mod_revision:4216 > success:<request_put:<key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-66dc596fcb-jl9lm\" value_size:11750 >> failure:<request_range:<key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-66dc596fcb-jl9lm\" > >"}
{"level":"info","ts":"2026-05-09T12:57:18.354453Z","caller":"traceutil/trace.go:171","msg":"trace[762654130] transaction","detail":"{read_only:false; response_revision:4696; number_of_response:1; }","duration":"247.446498ms","start":"2026-05-09T12:57:18.106979Z","end":"2026-05-09T12:57:18.354426Z","steps":["trace[762654130] 'process raft request'  (duration: 247.309145ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:57:18.354729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.562157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-09T12:57:18.354778Z","caller":"traceutil/trace.go:171","msg":"trace[1844725900] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4696; }","duration":"118.66166ms","start":"2026-05-09T12:57:18.236104Z","end":"2026-05-09T12:57:18.354766Z","steps":["trace[1844725900] 'agreement among raft nodes before linearized reading'  (duration: 118.491336ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:57:18.356988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.622206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"}
{"level":"info","ts":"2026-05-09T12:57:18.357026Z","caller":"traceutil/trace.go:171","msg":"trace[239531398] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4696; }","duration":"426.684468ms","start":"2026-05-09T12:57:17.93033Z","end":"2026-05-09T12:57:18.357015Z","steps":["trace[239531398] 'agreement among raft nodes before linearized reading'  (duration: 424.0674ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:57:18.35705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:57:17.930318Z","time spent":"426.724328ms","remote":"127.0.0.1:36700","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2106,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "}
{"level":"warn","ts":"2026-05-09T12:57:18.360928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.189789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2195929"}
{"level":"info","ts":"2026-05-09T12:57:18.360998Z","caller":"traceutil/trace.go:171","msg":"trace[22987242] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4695; }","duration":"461.304892ms","start":"2026-05-09T12:57:17.899677Z","end":"2026-05-09T12:57:18.360982Z","steps":["trace[22987242] 'agreement among raft nodes before linearized reading'  (duration: 453.85644ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:57:18.36137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:57:17.899659Z","time spent":"461.69264ms","remote":"127.0.0.1:36652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":47,"response size":2195953,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "}
{"level":"info","ts":"2026-05-09T12:57:18.542146Z","caller":"traceutil/trace.go:171","msg":"trace[602593063] transaction","detail":"{read_only:false; response_revision:4697; number_of_response:1; }","duration":"181.768601ms","start":"2026-05-09T12:57:18.360352Z","end":"2026-05-09T12:57:18.542121Z","steps":["trace[602593063] 'process raft request'  (duration: 181.599217ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:57:18.554021Z","caller":"traceutil/trace.go:171","msg":"trace[1683707634] transaction","detail":"{read_only:false; response_revision:4698; number_of_response:1; }","duration":"193.63762ms","start":"2026-05-09T12:57:18.36036Z","end":"2026-05-09T12:57:18.553998Z","steps":["trace[1683707634] 'process raft request'  (duration: 193.421354ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:57:18.554229Z","caller":"traceutil/trace.go:171","msg":"trace[1741560887] transaction","detail":"{read_only:false; response_revision:4699; number_of_response:1; }","duration":"191.219736ms","start":"2026-05-09T12:57:18.36299Z","end":"2026-05-09T12:57:18.55421Z","steps":["trace[1741560887] 'process raft request'  (duration: 190.948689ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:57:18.554229Z","caller":"traceutil/trace.go:171","msg":"trace[825810881] linearizableReadLoop","detail":"{readStateIndex:4873; appliedIndex:4871; }","duration":"193.686331ms","start":"2026-05-09T12:57:18.360508Z","end":"2026-05-09T12:57:18.554194Z","steps":["trace[825810881] 'read index received'  (duration: 181.416134ms)","trace[825810881] 'applied index is now lower than readState.Index'  (duration: 12.267567ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T12:57:18.55442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.890075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16233"}
{"level":"info","ts":"2026-05-09T12:57:18.554463Z","caller":"traceutil/trace.go:171","msg":"trace[1072237097] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4699; }","duration":"193.968036ms","start":"2026-05-09T12:57:18.360483Z","end":"2026-05-09T12:57:18.554451Z","steps":["trace[1072237097] 'agreement among raft nodes before linearized reading'  (duration: 193.790432ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:57:18.554586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.040397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-d7d0081e-f202-4146-949a-551c2b2b90f2\" ","response":"range_response_count:1 size:1435"}
{"level":"info","ts":"2026-05-09T12:57:18.554624Z","caller":"traceutil/trace.go:171","msg":"trace[1269165674] range","detail":"{range_begin:/registry/persistentvolumes/pvc-d7d0081e-f202-4146-949a-551c2b2b90f2; range_end:; response_count:1; response_revision:4699; }","duration":"194.110249ms","start":"2026-05-09T12:57:18.360503Z","end":"2026-05-09T12:57:18.554613Z","steps":["trace[1269165674] 'agreement among raft nodes before linearized reading'  (duration: 194.011797ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:57:18.554631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.427614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T12:57:18.554774Z","caller":"traceutil/trace.go:171","msg":"trace[1598261415] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:4699; }","duration":"101.64453ms","start":"2026-05-09T12:57:18.453112Z","end":"2026-05-09T12:57:18.554756Z","steps":["trace[1598261415] 'agreement among raft nodes before linearized reading'  (duration: 101.438525ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:57:18.554815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.950322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c526975c-e1e6-4246-abf7-cbd0184edaee\" ","response":"range_response_count:1 size:3646"}
{"level":"info","ts":"2026-05-09T12:57:18.554857Z","caller":"traceutil/trace.go:171","msg":"trace[51742038] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c526975c-e1e6-4246-abf7-cbd0184edaee; range_end:; response_count:1; response_revision:4699; }","duration":"134.032434ms","start":"2026-05-09T12:57:18.420815Z","end":"2026-05-09T12:57:18.554847Z","steps":["trace[51742038] 'agreement among raft nodes before linearized reading'  (duration: 133.928332ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:57:18.555088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.342695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"}
{"level":"info","ts":"2026-05-09T12:57:18.555125Z","caller":"traceutil/trace.go:171","msg":"trace[253293321] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4699; }","duration":"171.420766ms","start":"2026-05-09T12:57:18.383696Z","end":"2026-05-09T12:57:18.555117Z","steps":["trace[253293321] 'agreement among raft nodes before linearized reading'  (duration: 171.318894ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:57:19.177257Z","caller":"traceutil/trace.go:171","msg":"trace[820959984] transaction","detail":"{read_only:false; response_revision:4705; number_of_response:1; }","duration":"431.94781ms","start":"2026-05-09T12:57:18.745283Z","end":"2026-05-09T12:57:19.177231Z","steps":["trace[820959984] 'process raft request'  (duration: 431.749215ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:57:19.17744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:57:18.745267Z","time spent":"432.068072ms","remote":"127.0.0.1:37490","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7567,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" mod_revision:4690 > success:<request_put:<key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" value_size:7471 >> failure:<request_range:<key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" > >"}
{"level":"warn","ts":"2026-05-09T12:57:19.323229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.712111ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14208186177166127173 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:4622 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-09T12:57:19.32346Z","caller":"traceutil/trace.go:171","msg":"trace[816607778] linearizableReadLoop","detail":"{readStateIndex:4881; appliedIndex:4879; }","duration":"537.486587ms","start":"2026-05-09T12:57:18.785949Z","end":"2026-05-09T12:57:19.323435Z","steps":["trace[816607778] 'read index received'  (duration: 391.133563ms)","trace[816607778] 'applied index is now lower than readState.Index'  (duration: 146.351784ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:57:19.323839Z","caller":"traceutil/trace.go:171","msg":"trace[35962550] transaction","detail":"{read_only:false; response_revision:4706; number_of_response:1; }","duration":"541.785961ms","start":"2026-05-09T12:57:18.781945Z","end":"2026-05-09T12:57:19.323731Z","steps":["trace[35962550] 'process raft request'  (duration: 436.478648ms)","trace[35962550] 'compare'  (duration: 104.545386ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T12:57:19.323931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.959737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-05-09T12:57:19.323943Z","caller":"traceutil/trace.go:171","msg":"trace[1533787856] transaction","detail":"{read_only:false; response_revision:4707; number_of_response:1; }","duration":"308.382247ms","start":"2026-05-09T12:57:19.015521Z","end":"2026-05-09T12:57:19.323903Z","steps":["trace[1533787856] 'process raft request'  (duration: 307.841925ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:57:19.324021Z","caller":"traceutil/trace.go:171","msg":"trace[1065022857] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4707; }","duration":"538.078829ms","start":"2026-05-09T12:57:18.785913Z","end":"2026-05-09T12:57:19.323991Z","steps":["trace[1065022857] 'agreement among raft nodes before linearized reading'  (duration: 537.755892ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:57:19.324026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:57:18.781932Z","time spent":"541.991695ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:4622 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-05-09T12:57:19.324068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:57:18.785901Z","time spent":"538.15711ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-05-09T12:57:19.324112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.923557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-66dc596fcb-jl9lm.18ade7054bcb6c7e\" ","response":"range_response_count:1 size:896"}
{"level":"warn","ts":"2026-05-09T12:57:19.324156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.771211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"}
{"level":"warn","ts":"2026-05-09T12:57:19.324152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:57:19.015493Z","time spent":"308.549691ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:4630 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-09T12:57:19.32417Z","caller":"traceutil/trace.go:171","msg":"trace[1520734601] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-66dc596fcb-jl9lm.18ade7054bcb6c7e; range_end:; response_count:1; response_revision:4707; }","duration":"486.003868ms","start":"2026-05-09T12:57:18.83815Z","end":"2026-05-09T12:57:19.324154Z","steps":["trace[1520734601] 'agreement among raft nodes before linearized reading'  (duration: 485.814963ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:57:19.324212Z","caller":"traceutil/trace.go:171","msg":"trace[195642662] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4707; }","duration":"461.855813ms","start":"2026-05-09T12:57:18.862336Z","end":"2026-05-09T12:57:19.324192Z","steps":["trace[195642662] 'agreement among raft nodes before linearized reading'  (duration: 461.713009ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:57:19.324224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:57:18.838138Z","time spent":"486.07657ms","remote":"127.0.0.1:36620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":93,"response count":1,"response size":920,"request content":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-66dc596fcb-jl9lm.18ade7054bcb6c7e\" "}
{"level":"warn","ts":"2026-05-09T12:57:19.324246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:57:18.862319Z","time spent":"461.919094ms","remote":"127.0.0.1:36700","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2106,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "}
{"level":"warn","ts":"2026-05-09T12:57:19.324619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.666052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-05-09T12:57:19.324693Z","caller":"traceutil/trace.go:171","msg":"trace[1720882821] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4707; }","duration":"538.774024ms","start":"2026-05-09T12:57:18.785895Z","end":"2026-05-09T12:57:19.324669Z","steps":["trace[1720882821] 'agreement among raft nodes before linearized reading'  (duration: 537.971246ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:57:19.324769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:57:18.785874Z","time spent":"538.879726ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-05-09T12:57:20.080134Z","caller":"traceutil/trace.go:171","msg":"trace[1551499224] linearizableReadLoop","detail":"{readStateIndex:4897; appliedIndex:4896; }","duration":"192.651195ms","start":"2026-05-09T12:57:19.887453Z","end":"2026-05-09T12:57:20.080104Z","steps":["trace[1551499224] 'read index received'  (duration: 102.270548ms)","trace[1551499224] 'applied index is now lower than readState.Index'  (duration: 90.379097ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:57:20.080299Z","caller":"traceutil/trace.go:171","msg":"trace[2116811057] transaction","detail":"{read_only:false; response_revision:4722; number_of_response:1; }","duration":"220.796636ms","start":"2026-05-09T12:57:19.859449Z","end":"2026-05-09T12:57:20.080246Z","steps":["trace[2116811057] 'process raft request'  (duration: 130.352077ms)","trace[2116811057] 'compare'  (duration: 90.147812ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T12:57:20.080425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.954232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-66dc596fcb-jl9lm.18ade7054bcb6c7e\" ","response":"range_response_count:1 size:896"}
{"level":"warn","ts":"2026-05-09T12:57:20.080451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.007896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"}
{"level":"info","ts":"2026-05-09T12:57:20.080466Z","caller":"traceutil/trace.go:171","msg":"trace[514539511] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-66dc596fcb-jl9lm.18ade7054bcb6c7e; range_end:; response_count:1; response_revision:4722; }","duration":"193.050314ms","start":"2026-05-09T12:57:19.887405Z","end":"2026-05-09T12:57:20.080455Z","steps":["trace[514539511] 'agreement among raft nodes before linearized reading'  (duration: 192.884671ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:57:20.080496Z","caller":"traceutil/trace.go:171","msg":"trace[2056085169] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4722; }","duration":"130.096998ms","start":"2026-05-09T12:57:19.950385Z","end":"2026-05-09T12:57:20.080482Z","steps":["trace[2056085169] 'agreement among raft nodes before linearized reading'  (duration: 129.918764ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:57:20.326498Z","caller":"traceutil/trace.go:171","msg":"trace[1130328850] transaction","detail":"{read_only:false; response_revision:4725; number_of_response:1; }","duration":"155.603387ms","start":"2026-05-09T12:57:20.170847Z","end":"2026-05-09T12:57:20.326451Z","steps":["trace[1130328850] 'process raft request'  (duration: 107.125699ms)","trace[1130328850] 'compare'  (duration: 48.257274ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:57:20.326503Z","caller":"traceutil/trace.go:171","msg":"trace[1091419546] linearizableReadLoop","detail":"{readStateIndex:4900; appliedIndex:4899; }","duration":"105.459802ms","start":"2026-05-09T12:57:20.221002Z","end":"2026-05-09T12:57:20.326462Z","steps":["trace[1091419546] 'read index received'  (duration: 57.027884ms)","trace[1091419546] 'applied index is now lower than readState.Index'  (duration: 48.416927ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T12:57:20.327323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.31868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T12:57:20.327403Z","caller":"traceutil/trace.go:171","msg":"trace[1400107467] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:4726; }","duration":"106.427473ms","start":"2026-05-09T12:57:20.220958Z","end":"2026-05-09T12:57:20.327385Z","steps":["trace[1400107467] 'agreement among raft nodes before linearized reading'  (duration: 105.613395ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:57:20.574702Z","caller":"traceutil/trace.go:171","msg":"trace[1910826295] transaction","detail":"{read_only:false; response_revision:4730; number_of_response:1; }","duration":"241.052627ms","start":"2026-05-09T12:57:20.33362Z","end":"2026-05-09T12:57:20.574673Z","steps":["trace[1910826295] 'process raft request'  (duration: 240.821752ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:57:20.574777Z","caller":"traceutil/trace.go:171","msg":"trace[962969929] transaction","detail":"{read_only:false; response_revision:4729; number_of_response:1; }","duration":"241.19919ms","start":"2026-05-09T12:57:20.333555Z","end":"2026-05-09T12:57:20.574754Z","steps":["trace[962969929] 'process raft request'  (duration: 240.805601ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:57:20.574912Z","caller":"traceutil/trace.go:171","msg":"trace[127301415] transaction","detail":"{read_only:false; response_revision:4728; number_of_response:1; }","duration":"241.327263ms","start":"2026-05-09T12:57:20.333554Z","end":"2026-05-09T12:57:20.574882Z","steps":["trace[127301415] 'process raft request'  (duration: 236.786065ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:57:20.574954Z","caller":"traceutil/trace.go:171","msg":"trace[1208658916] transaction","detail":"{read_only:false; response_revision:4732; number_of_response:1; }","duration":"213.618913ms","start":"2026-05-09T12:57:20.361307Z","end":"2026-05-09T12:57:20.574926Z","steps":["trace[1208658916] 'process raft request'  (duration: 213.300086ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:57:20.575106Z","caller":"traceutil/trace.go:171","msg":"trace[1443472615] transaction","detail":"{read_only:false; response_revision:4731; number_of_response:1; }","duration":"231.50628ms","start":"2026-05-09T12:57:20.343297Z","end":"2026-05-09T12:57:20.574804Z","steps":["trace[1443472615] 'process raft request'  (duration: 231.206394ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:57:31.452069Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186177166127527,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-05-09T12:57:31.554546Z","caller":"traceutil/trace.go:171","msg":"trace[752225986] transaction","detail":"{read_only:false; response_revision:4854; number_of_response:1; }","duration":"670.331873ms","start":"2026-05-09T12:57:30.884178Z","end":"2026-05-09T12:57:31.554518Z","steps":["trace[752225986] 'process raft request'  (duration: 670.15025ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:57:31.554695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:57:30.884143Z","time spent":"670.478235ms","remote":"127.0.0.1:36732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11504,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:4031 > success:<request_put:<key:\"/registry/minions/instance\" value_size:11470 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-05-09T12:57:31.594404Z","caller":"traceutil/trace.go:171","msg":"trace[828005362] transaction","detail":"{read_only:false; response_revision:4855; number_of_response:1; }","duration":"222.465406ms","start":"2026-05-09T12:57:31.371922Z","end":"2026-05-09T12:57:31.594388Z","steps":["trace[828005362] 'process raft request'  (duration: 222.343663ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:57:31.594566Z","caller":"traceutil/trace.go:171","msg":"trace[1058694727] linearizableReadLoop","detail":"{readStateIndex:5037; appliedIndex:5034; }","duration":"642.864709ms","start":"2026-05-09T12:57:30.95168Z","end":"2026-05-09T12:57:31.594544Z","steps":["trace[1058694727] 'read index received'  (duration: 602.574107ms)","trace[1058694727] 'applied index is now lower than readState.Index'  (duration: 40.289312ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:57:31.594658Z","caller":"traceutil/trace.go:171","msg":"trace[1221702013] transaction","detail":"{read_only:false; response_revision:4856; number_of_response:1; }","duration":"180.802975ms","start":"2026-05-09T12:57:31.413838Z","end":"2026-05-09T12:57:31.594641Z","steps":["trace[1221702013] 'process raft request'  (duration: 180.519788ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:57:31.594764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"643.067554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10395"}
{"level":"warn","ts":"2026-05-09T12:57:31.595026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.714223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-05-09T12:57:31.595068Z","caller":"traceutil/trace.go:171","msg":"trace[1416442242] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4856; }","duration":"643.416401ms","start":"2026-05-09T12:57:30.951636Z","end":"2026-05-09T12:57:31.595052Z","steps":["trace[1416442242] 'agreement among raft nodes before linearized reading'  (duration: 643.006443ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:57:31.594886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.234485ms","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":"warn","ts":"2026-05-09T12:57:31.595137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:57:30.951617Z","time spent":"643.508303ms","remote":"127.0.0.1:36744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":10419,"request content":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" "}
{"level":"info","ts":"2026-05-09T12:57:31.595147Z","caller":"traceutil/trace.go:171","msg":"trace[345244959] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4856; }","duration":"103.888937ms","start":"2026-05-09T12:57:31.491233Z","end":"2026-05-09T12:57:31.595122Z","steps":["trace[345244959] 'agreement among raft nodes before linearized reading'  (duration: 103.505ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:57:31.59491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.814416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T12:57:31.595249Z","caller":"traceutil/trace.go:171","msg":"trace[285145005] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:4856; }","duration":"400.197503ms","start":"2026-05-09T12:57:31.195038Z","end":"2026-05-09T12:57:31.595235Z","steps":["trace[285145005] 'agreement among raft nodes before linearized reading'  (duration: 399.779385ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:57:31.595199Z","caller":"traceutil/trace.go:171","msg":"trace[441250340] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4856; }","duration":"565.548442ms","start":"2026-05-09T12:57:31.029585Z","end":"2026-05-09T12:57:31.595134Z","steps":["trace[441250340] 'agreement among raft nodes before linearized reading'  (duration: 565.094813ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:57:31.595292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:57:31.195026Z","time spent":"400.252156ms","remote":"127.0.0.1:54316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-05-09T12:57:31.59538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:57:31.029567Z","time spent":"565.763217ms","remote":"127.0.0.1:36700","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1889,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "}
{"level":"warn","ts":"2026-05-09T12:57:31.594895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.476265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-05-09T12:57:31.59546Z","caller":"traceutil/trace.go:171","msg":"trace[654079575] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4856; }","duration":"110.076518ms","start":"2026-05-09T12:57:31.485369Z","end":"2026-05-09T12:57:31.595446Z","steps":["trace[654079575] 'agreement among raft nodes before linearized reading'  (duration: 109.439504ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:57:33.029434Z","caller":"traceutil/trace.go:171","msg":"trace[823576500] linearizableReadLoop","detail":"{readStateIndex:5059; appliedIndex:5058; }","duration":"361.96748ms","start":"2026-05-09T12:57:32.667445Z","end":"2026-05-09T12:57:33.029413Z","steps":["trace[823576500] 'read index received'  (duration: 266.195139ms)","trace[823576500] 'applied index is now lower than readState.Index'  (duration: 95.771341ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:57:33.029863Z","caller":"traceutil/trace.go:171","msg":"trace[55469754] transaction","detail":"{read_only:false; response_revision:4877; number_of_response:1; }","duration":"375.813472ms","start":"2026-05-09T12:57:32.654019Z","end":"2026-05-09T12:57:33.029833Z","steps":["trace[55469754] 'process raft request'  (duration: 279.676893ms)","trace[55469754] 'compare'  (duration: 95.501865ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T12:57:33.030011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:57:32.653992Z","time spent":"375.944365ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:4851 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-05-09T12:57:33.030572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.084033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-05-09T12:57:33.0307Z","caller":"traceutil/trace.go:171","msg":"trace[1339891741] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4877; }","duration":"363.304227ms","start":"2026-05-09T12:57:32.667366Z","end":"2026-05-09T12:57:33.030671Z","steps":["trace[1339891741] 'agreement among raft nodes before linearized reading'  (duration: 362.117222ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:57:33.030832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:57:32.667334Z","time spent":"363.477701ms","remote":"127.0.0.1:36842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-05-09T12:58:07.418802Z","caller":"traceutil/trace.go:171","msg":"trace[266870246] transaction","detail":"{read_only:false; response_revision:5109; number_of_response:1; }","duration":"219.171503ms","start":"2026-05-09T12:58:07.199606Z","end":"2026-05-09T12:58:07.418777Z","steps":["trace[266870246] 'process raft request'  (duration: 123.63652ms)","trace[266870246] 'compare'  (duration: 95.205996ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:58:07.419481Z","caller":"traceutil/trace.go:171","msg":"trace[1364584073] transaction","detail":"{read_only:false; response_revision:5111; number_of_response:1; }","duration":"219.700923ms","start":"2026-05-09T12:58:07.199756Z","end":"2026-05-09T12:58:07.419457Z","steps":["trace[1364584073] 'process raft request'  (duration: 219.479989ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:58:07.419739Z","caller":"traceutil/trace.go:171","msg":"trace[1067090368] transaction","detail":"{read_only:false; response_revision:5112; number_of_response:1; }","duration":"219.898457ms","start":"2026-05-09T12:58:07.199817Z","end":"2026-05-09T12:58:07.419715Z","steps":["trace[1067090368] 'process raft request'  (duration: 219.492128ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:58:07.41986Z","caller":"traceutil/trace.go:171","msg":"trace[2141910935] linearizableReadLoop","detail":"{readStateIndex:5310; appliedIndex:5298; }","duration":"197.605065ms","start":"2026-05-09T12:58:07.22224Z","end":"2026-05-09T12:58:07.419845Z","steps":["trace[2141910935] 'read index received'  (duration: 100.994021ms)","trace[2141910935] 'applied index is now lower than readState.Index'  (duration: 96.610044ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:58:07.419956Z","caller":"traceutil/trace.go:171","msg":"trace[1325178328] transaction","detail":"{read_only:false; response_revision:5113; number_of_response:1; }","duration":"220.108351ms","start":"2026-05-09T12:58:07.199838Z","end":"2026-05-09T12:58:07.419947Z","steps":["trace[1325178328] 'process raft request'  (duration: 219.731263ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:58:07.420051Z","caller":"traceutil/trace.go:171","msg":"trace[1149764396] transaction","detail":"{read_only:false; response_revision:5114; number_of_response:1; }","duration":"220.143872ms","start":"2026-05-09T12:58:07.199899Z","end":"2026-05-09T12:58:07.420043Z","steps":["trace[1149764396] 'process raft request'  (duration: 219.728644ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:58:07.420153Z","caller":"traceutil/trace.go:171","msg":"trace[1690125953] transaction","detail":"{read_only:false; response_revision:5116; number_of_response:1; }","duration":"220.211183ms","start":"2026-05-09T12:58:07.199927Z","end":"2026-05-09T12:58:07.420138Z","steps":["trace[1690125953] 'process raft request'  (duration: 219.753914ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:58:07.420182Z","caller":"traceutil/trace.go:171","msg":"trace[1847229064] transaction","detail":"{read_only:false; response_revision:5119; number_of_response:1; }","duration":"220.125401ms","start":"2026-05-09T12:58:07.199991Z","end":"2026-05-09T12:58:07.420117Z","steps":["trace[1847229064] 'process raft request'  (duration: 219.764895ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:58:07.419415Z","caller":"traceutil/trace.go:171","msg":"trace[237640155] transaction","detail":"{read_only:false; response_revision:5110; number_of_response:1; }","duration":"219.660953ms","start":"2026-05-09T12:58:07.199678Z","end":"2026-05-09T12:58:07.419339Z","steps":["trace[237640155] 'process raft request'  (duration: 218.99567ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:58:07.421983Z","caller":"traceutil/trace.go:171","msg":"trace[245332473] transaction","detail":"{read_only:false; response_revision:5120; number_of_response:1; }","duration":"221.944198ms","start":"2026-05-09T12:58:07.200007Z","end":"2026-05-09T12:58:07.421951Z","steps":["trace[245332473] 'process raft request'  (duration: 219.804496ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:58:07.422192Z","caller":"traceutil/trace.go:171","msg":"trace[403546665] transaction","detail":"{read_only:false; response_revision:5117; number_of_response:1; }","duration":"222.198323ms","start":"2026-05-09T12:58:07.199961Z","end":"2026-05-09T12:58:07.42216Z","steps":["trace[403546665] 'process raft request'  (duration: 219.745085ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:58:07.422282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.967963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"}
{"level":"info","ts":"2026-05-09T12:58:07.422345Z","caller":"traceutil/trace.go:171","msg":"trace[511699460] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:5120; }","duration":"196.055045ms","start":"2026-05-09T12:58:07.22626Z","end":"2026-05-09T12:58:07.422315Z","steps":["trace[511699460] 'agreement among raft nodes before linearized reading'  (duration: 195.879231ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:58:07.422615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.426202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-05-09T12:58:07.422665Z","caller":"traceutil/trace.go:171","msg":"trace[430000834] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5120; }","duration":"193.488175ms","start":"2026-05-09T12:58:07.229163Z","end":"2026-05-09T12:58:07.422651Z","steps":["trace[430000834] 'agreement among raft nodes before linearized reading'  (duration: 193.353232ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:58:07.423534Z","caller":"traceutil/trace.go:171","msg":"trace[435987368] transaction","detail":"{read_only:false; response_revision:5115; number_of_response:1; }","duration":"220.346295ms","start":"2026-05-09T12:58:07.199929Z","end":"2026-05-09T12:58:07.420275Z","steps":["trace[435987368] 'process raft request'  (duration: 219.727004ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:58:07.423051Z","caller":"traceutil/trace.go:171","msg":"trace[1823680879] transaction","detail":"{read_only:false; response_revision:5118; number_of_response:1; }","duration":"223.059909ms","start":"2026-05-09T12:58:07.199967Z","end":"2026-05-09T12:58:07.423027Z","steps":["trace[1823680879] 'process raft request'  (duration: 219.765114ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:58:07.429167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.212852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2195929"}
{"level":"info","ts":"2026-05-09T12:58:07.429215Z","caller":"traceutil/trace.go:171","msg":"trace[307259501] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:5120; }","duration":"225.275123ms","start":"2026-05-09T12:58:07.203921Z","end":"2026-05-09T12:58:07.429196Z","steps":["trace[307259501] 'agreement among raft nodes before linearized reading'  (duration: 216.189423ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:58:10.060715Z","caller":"traceutil/trace.go:171","msg":"trace[700429590] transaction","detail":"{read_only:false; response_revision:5214; number_of_response:1; }","duration":"123.216052ms","start":"2026-05-09T12:58:09.937473Z","end":"2026-05-09T12:58:10.06069Z","steps":["trace[700429590] 'process raft request'  (duration: 87.012047ms)","trace[700429590] 'compare'  (duration: 36.102483ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:58:10.074701Z","caller":"traceutil/trace.go:171","msg":"trace[1541484707] linearizableReadLoop","detail":"{readStateIndex:5405; appliedIndex:5403; }","duration":"110.302047ms","start":"2026-05-09T12:58:09.964374Z","end":"2026-05-09T12:58:10.074676Z","steps":["trace[1541484707] 'read index received'  (duration: 60.142097ms)","trace[1541484707] 'applied index is now lower than readState.Index'  (duration: 50.15836ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-09T12:58:10.074871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.4743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-09T12:58:10.074782Z","caller":"traceutil/trace.go:171","msg":"trace[1203090612] transaction","detail":"{read_only:false; response_revision:5215; number_of_response:1; }","duration":"136.874371ms","start":"2026-05-09T12:58:09.937874Z","end":"2026-05-09T12:58:10.074749Z","steps":["trace[1203090612] 'process raft request'  (duration: 136.674317ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:58:10.074944Z","caller":"traceutil/trace.go:171","msg":"trace[790759535] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5215; }","duration":"110.609062ms","start":"2026-05-09T12:58:09.964322Z","end":"2026-05-09T12:58:10.074931Z","steps":["trace[790759535] 'agreement among raft nodes before linearized reading'  (duration: 110.451619ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:58:20.223566Z","caller":"traceutil/trace.go:171","msg":"trace[446780453] transaction","detail":"{read_only:false; response_revision:5273; number_of_response:1; }","duration":"100.703685ms","start":"2026-05-09T12:58:20.122817Z","end":"2026-05-09T12:58:20.22352Z","steps":["trace[446780453] 'process raft request'  (duration: 77.624397ms)","trace[446780453] 'compare'  (duration: 22.64505ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:58:27.426693Z","caller":"traceutil/trace.go:171","msg":"trace[1755306073] transaction","detail":"{read_only:false; response_revision:5328; number_of_response:1; }","duration":"109.474903ms","start":"2026-05-09T12:58:27.317194Z","end":"2026-05-09T12:58:27.426669Z","steps":["trace[1755306073] 'process raft request'  (duration: 109.32217ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:58:53.982282Z","caller":"traceutil/trace.go:171","msg":"trace[189487994] transaction","detail":"{read_only:false; response_revision:5523; number_of_response:1; }","duration":"138.807428ms","start":"2026-05-09T12:58:53.843451Z","end":"2026-05-09T12:58:53.982259Z","steps":["trace[189487994] 'process raft request'  (duration: 138.648775ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:58:54.083836Z","caller":"traceutil/trace.go:171","msg":"trace[1368224917] transaction","detail":"{read_only:false; response_revision:5524; number_of_response:1; }","duration":"126.934436ms","start":"2026-05-09T12:58:53.956859Z","end":"2026-05-09T12:58:54.083794Z","steps":["trace[1368224917] 'process raft request'  (duration: 89.525932ms)","trace[1368224917] 'compare'  (duration: 37.073018ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:58:54.083922Z","caller":"traceutil/trace.go:171","msg":"trace[406712942] transaction","detail":"{read_only:false; response_revision:5525; number_of_response:1; }","duration":"126.989527ms","start":"2026-05-09T12:58:53.956916Z","end":"2026-05-09T12:58:54.083905Z","steps":["trace[406712942] 'process raft request'  (duration: 126.700562ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:58:54.143548Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2862}
{"level":"warn","ts":"2026-05-09T12:58:54.285806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.853111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-09T12:58:54.285868Z","caller":"traceutil/trace.go:171","msg":"trace[1684130886] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5526; }","duration":"100.984084ms","start":"2026-05-09T12:58:54.184871Z","end":"2026-05-09T12:58:54.285855Z","steps":["trace[1684130886] 'range keys from in-memory index tree'  (duration: 100.681148ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:58:54.286305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.411031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-05-09T12:58:54.286359Z","caller":"traceutil/trace.go:171","msg":"trace[1018755844] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5526; }","duration":"101.511233ms","start":"2026-05-09T12:58:54.184835Z","end":"2026-05-09T12:58:54.286346Z","steps":["trace[1018755844] 'range keys from in-memory index tree'  (duration: 100.926181ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:58:54.536844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.412123ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14208186177166129247 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:5518 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-09T12:58:54.537049Z","caller":"traceutil/trace.go:171","msg":"trace[1537098591] transaction","detail":"{read_only:false; response_revision:5529; number_of_response:1; }","duration":"246.288498ms","start":"2026-05-09T12:58:54.290749Z","end":"2026-05-09T12:58:54.537038Z","steps":["trace[1537098591] 'process raft request'  (duration: 246.208606ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:58:54.537962Z","caller":"traceutil/trace.go:171","msg":"trace[1703563244] linearizableReadLoop","detail":"{readStateIndex:5731; appliedIndex:5728; }","duration":"120.507415ms","start":"2026-05-09T12:58:54.417437Z","end":"2026-05-09T12:58:54.537944Z","steps":["trace[1703563244] 'read index received'  (duration: 66.391µs)","trace[1703563244] 'applied index is now lower than readState.Index'  (duration: 120.439994ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:58:54.537983Z","caller":"traceutil/trace.go:171","msg":"trace[80130679] transaction","detail":"{read_only:false; response_revision:5530; number_of_response:1; }","duration":"246.042414ms","start":"2026-05-09T12:58:54.291919Z","end":"2026-05-09T12:58:54.537961Z","steps":["trace[80130679] 'process raft request'  (duration: 245.090066ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:58:54.538158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.718719ms","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-05-09T12:58:54.538208Z","caller":"traceutil/trace.go:171","msg":"trace[1662194172] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5530; }","duration":"120.83116ms","start":"2026-05-09T12:58:54.417366Z","end":"2026-05-09T12:58:54.538197Z","steps":["trace[1662194172] 'agreement among raft nodes before linearized reading'  (duration: 120.671797ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:58:54.538258Z","caller":"traceutil/trace.go:171","msg":"trace[269189612] transaction","detail":"{read_only:false; response_revision:5528; number_of_response:1; }","duration":"248.199863ms","start":"2026-05-09T12:58:54.290021Z","end":"2026-05-09T12:58:54.538221Z","steps":["trace[269189612] 'process raft request'  (duration: 98.363564ms)","trace[269189612] 'compare'  (duration: 142.740538ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:58:54.683749Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2862,"took":"538.854426ms","hash":1369049816,"current-db-size-bytes":53846016,"current-db-size":"54 MB","current-db-size-in-use-bytes":28864512,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-05-09T12:58:54.68384Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1369049816,"revision":2862,"compact-revision":-1}
{"level":"warn","ts":"2026-05-09T12:58:54.684442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.836064ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14208186177166129251 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:5520 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-09T12:58:54.684725Z","caller":"traceutil/trace.go:171","msg":"trace[211854833] transaction","detail":"{read_only:false; response_revision:5531; number_of_response:1; }","duration":"142.86655ms","start":"2026-05-09T12:58:54.541837Z","end":"2026-05-09T12:58:54.684703Z","steps":["trace[211854833] 'compare'  (duration: 132.558409ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T12:59:05.801613Z","caller":"traceutil/trace.go:171","msg":"trace[1768243314] transaction","detail":"{read_only:false; response_revision:5619; number_of_response:1; }","duration":"151.711669ms","start":"2026-05-09T12:59:05.649879Z","end":"2026-05-09T12:59:05.801591Z","steps":["trace[1768243314] 'process raft request'  (duration: 117.40154ms)","trace[1768243314] 'compare'  (duration: 34.194077ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:59:06.135059Z","caller":"traceutil/trace.go:171","msg":"trace[950995752] linearizableReadLoop","detail":"{readStateIndex:5826; appliedIndex:5825; }","duration":"140.887277ms","start":"2026-05-09T12:59:05.994149Z","end":"2026-05-09T12:59:06.135036Z","steps":["trace[950995752] 'read index received'  (duration: 140.618313ms)","trace[950995752] 'applied index is now lower than readState.Index'  (duration: 268.104µs)"],"step_count":2}
{"level":"info","ts":"2026-05-09T12:59:06.135201Z","caller":"traceutil/trace.go:171","msg":"trace[359539878] transaction","detail":"{read_only:false; response_revision:5623; number_of_response:1; }","duration":"176.753644ms","start":"2026-05-09T12:59:05.958437Z","end":"2026-05-09T12:59:06.13519Z","steps":["trace[359539878] 'process raft request'  (duration: 176.403628ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-09T12:59:06.135489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.318285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-09T12:59:06.135614Z","caller":"traceutil/trace.go:171","msg":"trace[1049965469] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:5623; }","duration":"141.497619ms","start":"2026-05-09T12:59:05.994095Z","end":"2026-05-09T12:59:06.135593Z","steps":["trace[1049965469] 'agreement among raft nodes before linearized reading'  (duration: 141.327826ms)"],"step_count":1}
{"level":"info","ts":"2026-05-09T13:01:17.239994Z","caller":"traceutil/trace.go:171","msg":"trace[1850690623] transaction","detail":"{read_only:false; response_revision:6505; number_of_response:1; }","duration":"151.930628ms","start":"2026-05-09T13:01:17.088031Z","end":"2026-05-09T13:01:17.239962Z","steps":["trace[1850690623] 'process raft request'  (duration: 120.732369ms)","trace[1850690623] 'compare'  (duration: 31.060617ms)"],"step_count":2}
{"level":"info","ts":"2026-05-09T13:03:54.148567Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5526}
{"level":"info","ts":"2026-05-09T13:03:54.217816Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5526,"took":"68.041698ms","hash":2487050262,"current-db-size-bytes":53846016,"current-db-size":"54 MB","current-db-size-in-use-bytes":18067456,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-05-09T13:03:54.217893Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2487050262,"revision":5526,"compact-revision":2862}