{"level":"warn","ts":"2026-06-30T22:16:10.92982Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-30T22:16:10.929937Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.240: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.240:2380","--initial-cluster=instance=https://199.204.45.240:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.240:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.240:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-30T22:16:10.930025Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-30T22:16:10.930043Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.240:2380"]} {"level":"info","ts":"2026-06-30T22:16:10.930068Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-30T22:16:10.931029Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"]} {"level":"info","ts":"2026-06-30T22:16:10.931149Z","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.240:2380"],"listen-peer-urls":["https://199.204.45.240:2380"],"advertise-client-urls":["https://199.204.45.240:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.240:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-30T22:16:10.937309Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.865896ms"} {"level":"info","ts":"2026-06-30T22:16:10.949244Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4e46287fb5aa4785","cluster-id":"cae704afa9813e87"} {"level":"info","ts":"2026-06-30T22:16:10.949747Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=()"} {"level":"info","ts":"2026-06-30T22:16:10.950721Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became follower at term 0"} {"level":"info","ts":"2026-06-30T22:16:10.950873Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4e46287fb5aa4785 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-30T22:16:10.950997Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became follower at term 1"} {"level":"info","ts":"2026-06-30T22:16:10.952491Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=(5640240112301918085)"} {"level":"warn","ts":"2026-06-30T22:16:10.962308Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-30T22:16:10.963824Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-30T22:16:10.96493Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-30T22:16:10.968081Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4e46287fb5aa4785","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-30T22:16:10.970498Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4e46287fb5aa4785","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-30T22:16:10.970593Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-30T22:16:10.970717Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-30T22:16:10.970738Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-30T22:16:10.972509Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-30T22:16:10.972705Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.240:2380"} {"level":"info","ts":"2026-06-30T22:16:10.972799Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.240:2380"} {"level":"info","ts":"2026-06-30T22:16:10.973069Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4e46287fb5aa4785","initial-advertise-peer-urls":["https://199.204.45.240:2380"],"listen-peer-urls":["https://199.204.45.240:2380"],"advertise-client-urls":["https://199.204.45.240:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-30T22:16:10.973131Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-30T22:16:10.973155Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=(5640240112301918085)"} {"level":"info","ts":"2026-06-30T22:16:10.973296Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cae704afa9813e87","local-member-id":"4e46287fb5aa4785","added-peer-id":"4e46287fb5aa4785","added-peer-peer-urls":["https://199.204.45.240:2380"]} {"level":"info","ts":"2026-06-30T22:16:11.153385Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 is starting a new election at term 1"} {"level":"info","ts":"2026-06-30T22:16:11.153461Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-30T22:16:11.153496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 received MsgPreVoteResp from 4e46287fb5aa4785 at term 1"} {"level":"info","ts":"2026-06-30T22:16:11.15352Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became candidate at term 2"} {"level":"info","ts":"2026-06-30T22:16:11.153531Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 received MsgVoteResp from 4e46287fb5aa4785 at term 2"} {"level":"info","ts":"2026-06-30T22:16:11.153548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became leader at term 2"} {"level":"info","ts":"2026-06-30T22:16:11.153567Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4e46287fb5aa4785 elected leader 4e46287fb5aa4785 at term 2"} {"level":"info","ts":"2026-06-30T22:16:11.154408Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T22:16:11.155169Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-30T22:16:11.155223Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4e46287fb5aa4785","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.240:2379]}","request-path":"/0/members/4e46287fb5aa4785/attributes","cluster-id":"cae704afa9813e87","publish-timeout":"7s"} {"level":"info","ts":"2026-06-30T22:16:11.155319Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-30T22:16:11.155593Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cae704afa9813e87","local-member-id":"4e46287fb5aa4785","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T22:16:11.155712Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T22:16:11.155754Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T22:16:11.155885Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-30T22:16:11.155921Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-30T22:16:11.158883Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.240:2379"} {"level":"info","ts":"2026-06-30T22:16:11.158971Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-06-30T22:16:20.292955Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153700285208054574,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-30T22:16:20.301382Z","caller":"traceutil/trace.go:171","msg":"trace[364616315] linearizableReadLoop","detail":"{readStateIndex:366; appliedIndex:365; }","duration":"508.915369ms","start":"2026-06-30T22:16:19.792442Z","end":"2026-06-30T22:16:20.301357Z","steps":["trace[364616315] 'read index received' (duration: 508.812078ms)","trace[364616315] 'applied index is now lower than readState.Index' (duration: 101.881µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:16:20.301583Z","caller":"traceutil/trace.go:171","msg":"trace[1090932730] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"550.957865ms","start":"2026-06-30T22:16:19.75058Z","end":"2026-06-30T22:16:20.301538Z","steps":["trace[1090932730] 'process raft request' (duration: 550.616602ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:16:20.301635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.12186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"warn","ts":"2026-06-30T22:16:20.301618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.14299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-06-30T22:16:20.301714Z","caller":"traceutil/trace.go:171","msg":"trace[610315801] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:352; }","duration":"310.272771ms","start":"2026-06-30T22:16:19.991427Z","end":"2026-06-30T22:16:20.3017Z","steps":["trace[610315801] 'agreement among raft nodes before linearized reading' (duration: 310.10566ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:16:20.301737Z","caller":"traceutil/trace.go:171","msg":"trace[1188190786] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:352; }","duration":"509.352281ms","start":"2026-06-30T22:16:19.792364Z","end":"2026-06-30T22:16:20.301716Z","steps":["trace[1188190786] 'agreement among raft nodes before linearized reading' (duration: 509.127139ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:16:20.301748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:16:19.99139Z","time spent":"310.352971ms","remote":"127.0.0.1:46432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":226,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"warn","ts":"2026-06-30T22:16:20.301804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:16:19.792334Z","time spent":"509.461242ms","remote":"127.0.0.1:46432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" "} {"level":"warn","ts":"2026-06-30T22:16:20.301676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.097305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-06-30T22:16:20.301936Z","caller":"traceutil/trace.go:171","msg":"trace[1976531345] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:352; }","duration":"459.534328ms","start":"2026-06-30T22:16:19.842392Z","end":"2026-06-30T22:16:20.301926Z","steps":["trace[1976531345] 'agreement among raft nodes before linearized reading' (duration: 459.122045ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:16:20.301963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.538004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-06-30T22:16:20.30205Z","caller":"traceutil/trace.go:171","msg":"trace[695485495] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:352; }","duration":"409.675245ms","start":"2026-06-30T22:16:19.892337Z","end":"2026-06-30T22:16:20.302013Z","steps":["trace[695485495] 'agreement among raft nodes before linearized reading' (duration: 409.532074ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:16:20.301979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:16:19.842363Z","time spent":"459.602149ms","remote":"127.0.0.1:46432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":220,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" "} {"level":"warn","ts":"2026-06-30T22:16:20.302125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:16:19.892322Z","time spent":"409.767996ms","remote":"127.0.0.1:46432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"warn","ts":"2026-06-30T22:16:20.302617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:16:19.750565Z","time spent":"551.121756ms","remote":"127.0.0.1:46404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4355,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T22:16:20.303556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.03026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-06-30T22:16:20.304146Z","caller":"traceutil/trace.go:171","msg":"trace[1175221416] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:352; }","duration":"361.642294ms","start":"2026-06-30T22:16:19.942484Z","end":"2026-06-30T22:16:20.304126Z","steps":["trace[1175221416] 'agreement among raft nodes before linearized reading' (duration: 359.221497ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:16:20.304355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:16:19.942416Z","time spent":"361.849906ms","remote":"127.0.0.1:46432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":257,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "} {"level":"warn","ts":"2026-06-30T22:16:25.795276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.534891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T22:16:25.795418Z","caller":"traceutil/trace.go:171","msg":"trace[466151327] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:406; }","duration":"298.755003ms","start":"2026-06-30T22:16:25.496634Z","end":"2026-06-30T22:16:25.795389Z","steps":["trace[466151327] 'range keys from in-memory index tree' (duration: 298.435701ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:16:25.795414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.887823ms","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-06-30T22:16:25.795476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.547542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-30T22:16:25.795538Z","caller":"traceutil/trace.go:171","msg":"trace[1932103312] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:406; }","duration":"175.092684ms","start":"2026-06-30T22:16:25.620419Z","end":"2026-06-30T22:16:25.795511Z","steps":["trace[1932103312] 'range keys from in-memory index tree' (duration: 174.615942ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:16:25.795616Z","caller":"traceutil/trace.go:171","msg":"trace[1945360869] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:406; }","duration":"285.712453ms","start":"2026-06-30T22:16:25.509861Z","end":"2026-06-30T22:16:25.795574Z","steps":["trace[1945360869] 'range keys from in-memory index tree' (duration: 285.44655ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:16:36.97007Z","caller":"traceutil/trace.go:171","msg":"trace[2081482164] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"183.257972ms","start":"2026-06-30T22:16:36.786783Z","end":"2026-06-30T22:16:36.970041Z","steps":["trace[2081482164] 'process raft request' (duration: 182.91228ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:16:47.93403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.256299ms","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-06-30T22:16:47.934155Z","caller":"traceutil/trace.go:171","msg":"trace[1944317797] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:553; }","duration":"460.39195ms","start":"2026-06-30T22:16:47.473746Z","end":"2026-06-30T22:16:47.934138Z","steps":["trace[1944317797] 'range keys from in-memory index tree' (duration: 460.242229ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:16:47.935024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.318177ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T22:16:47.935309Z","caller":"traceutil/trace.go:171","msg":"trace[1324089176] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"723.741588ms","start":"2026-06-30T22:16:47.211502Z","end":"2026-06-30T22:16:47.935244Z","steps":["trace[1324089176] 'process raft request' (duration: 600.365825ms)","trace[1324089176] 'compare' (duration: 122.111455ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:16:47.935344Z","caller":"traceutil/trace.go:171","msg":"trace[1882935424] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"702.128996ms","start":"2026-06-30T22:16:47.233198Z","end":"2026-06-30T22:16:47.935327Z","steps":["trace[1882935424] 'process raft request' (duration: 701.931214ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:16:47.935472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:16:47.211481Z","time spent":"723.918469ms","remote":"127.0.0.1:46258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T22:16:47.93545Z","caller":"traceutil/trace.go:171","msg":"trace[567792059] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"697.319147ms","start":"2026-06-30T22:16:47.238106Z","end":"2026-06-30T22:16:47.935425Z","steps":["trace[567792059] 'process raft request' (duration: 697.149746ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:16:47.93549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:16:47.233145Z","time spent":"702.275597ms","remote":"127.0.0.1:46258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29452,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T22:16:47.935593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:16:47.238096Z","time spent":"697.417788ms","remote":"127.0.0.1:46258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T22:16:47.9357Z","caller":"traceutil/trace.go:171","msg":"trace[1023308991] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"642.732974ms","start":"2026-06-30T22:16:47.292957Z","end":"2026-06-30T22:16:47.93569Z","steps":["trace[1023308991] 'process raft request' (duration: 642.373482ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:16:47.93571Z","caller":"traceutil/trace.go:171","msg":"trace[340983211] linearizableReadLoop","detail":"{readStateIndex:580; appliedIndex:576; }","duration":"439.589934ms","start":"2026-06-30T22:16:47.496096Z","end":"2026-06-30T22:16:47.935686Z","steps":["trace[340983211] 'read index received' (duration: 315.706968ms)","trace[340983211] 'applied index is now lower than readState.Index' (duration: 123.881056ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:16:47.935745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:16:47.292933Z","time spent":"642.792394ms","remote":"127.0.0.1:46258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T22:16:47.935851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.758995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T22:16:47.935887Z","caller":"traceutil/trace.go:171","msg":"trace[1385096847] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:557; }","duration":"439.832745ms","start":"2026-06-30T22:16:47.496045Z","end":"2026-06-30T22:16:47.935878Z","steps":["trace[1385096847] 'agreement among raft nodes before linearized reading' (duration: 439.743795ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:16:47.935915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:16:47.496023Z","time spent":"439.885975ms","remote":"127.0.0.1:46210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-30T22:16:50.83415Z","caller":"traceutil/trace.go:171","msg":"trace[1021778618] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"117.77176ms","start":"2026-06-30T22:16:50.716353Z","end":"2026-06-30T22:16:50.834125Z","steps":["trace[1021778618] 'process raft request' (duration: 117.64013ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:16:54.637924Z","caller":"traceutil/trace.go:171","msg":"trace[1850217798] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"268.967426ms","start":"2026-06-30T22:16:54.368914Z","end":"2026-06-30T22:16:54.637881Z","steps":["trace[1850217798] 'process raft request' (duration: 268.755348ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:16:55.133342Z","caller":"traceutil/trace.go:171","msg":"trace[1316420548] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"662.210812ms","start":"2026-06-30T22:16:54.471085Z","end":"2026-06-30T22:16:55.133296Z","steps":["trace[1316420548] 'process raft request' (duration: 661.90174ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:16:55.133501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:16:54.471056Z","time spent":"662.367568ms","remote":"127.0.0.1:46232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T22:16:55.133933Z","caller":"traceutil/trace.go:171","msg":"trace[137067200] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"646.820103ms","start":"2026-06-30T22:16:54.48709Z","end":"2026-06-30T22:16:55.13391Z","steps":["trace[137067200] 'process raft request' (duration: 646.323584ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:16:55.134092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:16:54.487061Z","time spent":"646.952268ms","remote":"127.0.0.1:46306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T22:16:55.998888Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153700285208055170,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-30T22:16:56.067688Z","caller":"traceutil/trace.go:171","msg":"trace[2046969182] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"874.516289ms","start":"2026-06-30T22:16:55.193122Z","end":"2026-06-30T22:16:56.067639Z","steps":["trace[2046969182] 'process raft request' (duration: 874.243669ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:16:56.067857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:16:55.193101Z","time spent":"874.687006ms","remote":"127.0.0.1:46464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T22:16:56.067892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.870026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T22:16:56.067964Z","caller":"traceutil/trace.go:171","msg":"trace[414913019] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:639; }","duration":"570.000761ms","start":"2026-06-30T22:16:55.497943Z","end":"2026-06-30T22:16:56.067944Z","steps":["trace[414913019] 'agreement among raft nodes before linearized reading' (duration: 569.856616ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:16:56.068015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:16:55.497921Z","time spent":"570.085284ms","remote":"127.0.0.1:46216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-30T22:16:56.067762Z","caller":"traceutil/trace.go:171","msg":"trace[691246234] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:663; }","duration":"569.545244ms","start":"2026-06-30T22:16:55.497995Z","end":"2026-06-30T22:16:56.067541Z","steps":["trace[691246234] 'read index received' (duration: 569.286504ms)","trace[691246234] 'applied index is now lower than readState.Index' (duration: 257.94µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:16:58.28325Z","caller":"traceutil/trace.go:171","msg":"trace[1267100664] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"114.049433ms","start":"2026-06-30T22:16:58.16917Z","end":"2026-06-30T22:16:58.28322Z","steps":["trace[1267100664] 'process raft request' (duration: 81.314848ms)","trace[1267100664] 'compare' (duration: 32.60897ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:17:09.417058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.983228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-30T22:17:09.417154Z","caller":"traceutil/trace.go:171","msg":"trace[730273675] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:785; }","duration":"215.116143ms","start":"2026-06-30T22:17:09.202008Z","end":"2026-06-30T22:17:09.417124Z","steps":["trace[730273675] 'range keys from in-memory index tree' (duration: 214.834813ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:17:09.417294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.528599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-30T22:17:09.417384Z","caller":"traceutil/trace.go:171","msg":"trace[487585507] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:785; }","duration":"165.662513ms","start":"2026-06-30T22:17:09.251701Z","end":"2026-06-30T22:17:09.417363Z","steps":["trace[487585507] 'range keys from in-memory index tree' (duration: 165.326653ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:17:12.997645Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153700285208055485,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-30T22:17:13.09673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"793.15311ms","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-06-30T22:17:13.096841Z","caller":"traceutil/trace.go:171","msg":"trace[669119271] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:801; }","duration":"793.297464ms","start":"2026-06-30T22:17:12.303506Z","end":"2026-06-30T22:17:13.096804Z","steps":["trace[669119271] 'range keys from in-memory index tree' (duration: 792.954784ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:17:13.096898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:17:12.303485Z","time spent":"793.390537ms","remote":"127.0.0.1:46478","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-06-30T22:17:13.096916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"762.479856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-30T22:17:13.097023Z","caller":"traceutil/trace.go:171","msg":"trace[8443788] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:801; }","duration":"762.629512ms","start":"2026-06-30T22:17:12.334361Z","end":"2026-06-30T22:17:13.09699Z","steps":["trace[8443788] 'range keys from in-memory index tree' (duration: 762.26093ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:17:13.09707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:17:12.334339Z","time spent":"762.721594ms","remote":"127.0.0.1:46478","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-06-30T22:17:13.304913Z","caller":"traceutil/trace.go:171","msg":"trace[1331873576] linearizableReadLoop","detail":"{readStateIndex:831; appliedIndex:830; }","duration":"808.085372ms","start":"2026-06-30T22:17:12.496799Z","end":"2026-06-30T22:17:13.304884Z","steps":["trace[1331873576] 'read index received' (duration: 807.869805ms)","trace[1331873576] 'applied index is now lower than readState.Index' (duration: 214.397µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:17:13.305064Z","caller":"traceutil/trace.go:171","msg":"trace[1550394272] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"836.713591ms","start":"2026-06-30T22:17:12.468336Z","end":"2026-06-30T22:17:13.30505Z","steps":["trace[1550394272] 'process raft request' (duration: 836.331659ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:17:13.305216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:17:12.468292Z","time spent":"836.817505ms","remote":"127.0.0.1:46464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T22:17:13.305344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"808.531115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T22:17:13.305411Z","caller":"traceutil/trace.go:171","msg":"trace[1224828629] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:802; }","duration":"808.646319ms","start":"2026-06-30T22:17:12.496748Z","end":"2026-06-30T22:17:13.305394Z","steps":["trace[1224828629] 'agreement among raft nodes before linearized reading' (duration: 808.535605ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:17:13.305461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:17:12.496739Z","time spent":"808.711971ms","remote":"127.0.0.1:46216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-30T22:17:13.313541Z","caller":"traceutil/trace.go:171","msg":"trace[1213668641] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"212.262752ms","start":"2026-06-30T22:17:13.101255Z","end":"2026-06-30T22:17:13.313518Z","steps":["trace[1213668641] 'process raft request' (duration: 211.88096ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:17:13.313973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.715128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-06-30T22:17:13.314014Z","caller":"traceutil/trace.go:171","msg":"trace[1831908480] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"212.350334ms","start":"2026-06-30T22:17:13.101651Z","end":"2026-06-30T22:17:13.314002Z","steps":["trace[1831908480] 'process raft request' (duration: 211.804607ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:17:13.314036Z","caller":"traceutil/trace.go:171","msg":"trace[564771661] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:804; }","duration":"175.820021ms","start":"2026-06-30T22:17:13.138198Z","end":"2026-06-30T22:17:13.314018Z","steps":["trace[564771661] 'agreement among raft nodes before linearized reading' (duration: 175.649266ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:17:36.208628Z","caller":"traceutil/trace.go:171","msg":"trace[1242298038] transaction","detail":"{read_only:false; response_revision:1163; number_of_response:1; }","duration":"138.438562ms","start":"2026-06-30T22:17:36.070164Z","end":"2026-06-30T22:17:36.208602Z","steps":["trace[1242298038] 'process raft request' (duration: 138.312409ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:17:36.709453Z","caller":"traceutil/trace.go:171","msg":"trace[2067068456] transaction","detail":"{read_only:false; response_revision:1166; number_of_response:1; }","duration":"137.16325ms","start":"2026-06-30T22:17:36.572266Z","end":"2026-06-30T22:17:36.709429Z","steps":["trace[2067068456] 'process raft request' (duration: 137.018317ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:17:37.742285Z","caller":"traceutil/trace.go:171","msg":"trace[1821310983] transaction","detail":"{read_only:false; response_revision:1173; number_of_response:1; }","duration":"169.626365ms","start":"2026-06-30T22:17:37.572626Z","end":"2026-06-30T22:17:37.742252Z","steps":["trace[1821310983] 'process raft request' (duration: 151.974463ms)","trace[1821310983] 'compare' (duration: 17.118979ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:17:44.216362Z","caller":"traceutil/trace.go:171","msg":"trace[779375779] linearizableReadLoop","detail":"{readStateIndex:1245; appliedIndex:1244; }","duration":"114.786175ms","start":"2026-06-30T22:17:44.101553Z","end":"2026-06-30T22:17:44.216339Z","steps":["trace[779375779] 'read index received' (duration: 81.388629ms)","trace[779375779] 'applied index is now lower than readState.Index' (duration: 33.396286ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:17:44.216423Z","caller":"traceutil/trace.go:171","msg":"trace[224885036] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"230.450284ms","start":"2026-06-30T22:17:43.985943Z","end":"2026-06-30T22:17:44.216393Z","steps":["trace[224885036] 'process raft request' (duration: 197.046517ms)","trace[224885036] 'compare' (duration: 33.09878ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:17:44.216494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.921378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T22:17:44.216528Z","caller":"traceutil/trace.go:171","msg":"trace[752690306] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1209; }","duration":"115.011191ms","start":"2026-06-30T22:17:44.101508Z","end":"2026-06-30T22:17:44.216519Z","steps":["trace[752690306] 'agreement among raft nodes before linearized reading' (duration: 114.921899ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:18:31.009058Z","caller":"traceutil/trace.go:171","msg":"trace[2107962366] transaction","detail":"{read_only:false; response_revision:1793; number_of_response:1; }","duration":"117.514231ms","start":"2026-06-30T22:18:30.891521Z","end":"2026-06-30T22:18:31.009035Z","steps":["trace[2107962366] 'process raft request' (duration: 117.368689ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:18:39.432628Z","caller":"traceutil/trace.go:171","msg":"trace[1523250463] linearizableReadLoop","detail":"{readStateIndex:1979; appliedIndex:1978; }","duration":"388.760283ms","start":"2026-06-30T22:18:39.043835Z","end":"2026-06-30T22:18:39.432595Z","steps":["trace[1523250463] 'read index received' (duration: 388.52605ms)","trace[1523250463] 'applied index is now lower than readState.Index' (duration: 232.823µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:18:39.432731Z","caller":"traceutil/trace.go:171","msg":"trace[301460016] transaction","detail":"{read_only:false; response_revision:1907; number_of_response:1; }","duration":"474.662636ms","start":"2026-06-30T22:18:38.958023Z","end":"2026-06-30T22:18:39.432685Z","steps":["trace[301460016] 'process raft request' (duration: 474.421592ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:18:39.432933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:18:38.957998Z","time spent":"474.842678ms","remote":"127.0.0.1:46478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T22:18:39.432942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.086898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-06-30T22:18:39.433053Z","caller":"traceutil/trace.go:171","msg":"trace[1128011200] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1907; }","duration":"389.246271ms","start":"2026-06-30T22:18:39.04379Z","end":"2026-06-30T22:18:39.433037Z","steps":["trace[1128011200] 'agreement among raft nodes before linearized reading' (duration: 388.997647ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:18:39.433132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:18:39.043775Z","time spent":"389.344122ms","remote":"127.0.0.1:46478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":577,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-06-30T22:18:39.815985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.361429ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T22:18:39.816252Z","caller":"traceutil/trace.go:171","msg":"trace[61073606] transaction","detail":"{read_only:false; response_revision:1908; number_of_response:1; }","duration":"377.986304ms","start":"2026-06-30T22:18:39.438233Z","end":"2026-06-30T22:18:39.816219Z","steps":["trace[61073606] 'process raft request' (duration: 238.259249ms)","trace[61073606] 'compare' (duration: 138.996274ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:18:39.8165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:18:39.438209Z","time spent":"378.177846ms","remote":"127.0.0.1:46478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T22:18:39.994773Z","caller":"traceutil/trace.go:171","msg":"trace[2017156658] transaction","detail":"{read_only:false; response_revision:1909; number_of_response:1; }","duration":"102.060755ms","start":"2026-06-30T22:18:39.892675Z","end":"2026-06-30T22:18:39.994736Z","steps":["trace[2017156658] 'process raft request' (duration: 101.819432ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:18:40.353447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.855555ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T22:18:40.353906Z","caller":"traceutil/trace.go:171","msg":"trace[122790203] transaction","detail":"{read_only:false; response_revision:1911; number_of_response:1; }","duration":"342.464766ms","start":"2026-06-30T22:18:40.011378Z","end":"2026-06-30T22:18:40.353843Z","steps":["trace[122790203] 'process raft request' (duration: 29.143194ms)","trace[122790203] 'compare' (duration: 312.774074ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:18:40.353997Z","caller":"traceutil/trace.go:171","msg":"trace[553740501] transaction","detail":"{read_only:false; response_revision:1912; number_of_response:1; }","duration":"341.447801ms","start":"2026-06-30T22:18:40.01251Z","end":"2026-06-30T22:18:40.353958Z","steps":["trace[553740501] 'process raft request' (duration: 341.054665ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:18:40.3541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:18:40.011358Z","time spent":"342.657569ms","remote":"127.0.0.1:46478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T22:18:40.354157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:18:40.012498Z","time spent":"341.579663ms","remote":"127.0.0.1:46478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T22:18:40.354388Z","caller":"traceutil/trace.go:171","msg":"trace[1870287936] linearizableReadLoop","detail":"{readStateIndex:1987; appliedIndex:1983; }","duration":"340.476457ms","start":"2026-06-30T22:18:40.013891Z","end":"2026-06-30T22:18:40.354368Z","steps":["trace[1870287936] 'read index received' (duration: 26.639618ms)","trace[1870287936] 'applied index is now lower than readState.Index' (duration: 313.835909ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:18:40.354406Z","caller":"traceutil/trace.go:171","msg":"trace[1132405636] transaction","detail":"{read_only:false; response_revision:1913; number_of_response:1; }","duration":"341.137716ms","start":"2026-06-30T22:18:40.013235Z","end":"2026-06-30T22:18:40.354372Z","steps":["trace[1132405636] 'process raft request' (duration: 340.370035ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:18:40.354536Z","caller":"traceutil/trace.go:171","msg":"trace[276727834] transaction","detail":"{read_only:false; response_revision:1914; number_of_response:1; }","duration":"340.844033ms","start":"2026-06-30T22:18:40.013626Z","end":"2026-06-30T22:18:40.35447Z","steps":["trace[276727834] 'process raft request' (duration: 340.65617ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:18:40.35456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:18:40.013225Z","time spent":"341.256768ms","remote":"127.0.0.1:46478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T22:18:40.354565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.67201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T22:18:40.354611Z","caller":"traceutil/trace.go:171","msg":"trace[69463667] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1914; }","duration":"340.761231ms","start":"2026-06-30T22:18:40.013836Z","end":"2026-06-30T22:18:40.354598Z","steps":["trace[69463667] 'agreement among raft nodes before linearized reading' (duration: 340.65853ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:18:40.354663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:18:40.013814Z","time spent":"340.840022ms","remote":"127.0.0.1:46258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":54,"response size":30,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"warn","ts":"2026-06-30T22:18:40.354687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:18:40.013618Z","time spent":"340.958684ms","remote":"127.0.0.1:46478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T22:18:40.36226Z","caller":"traceutil/trace.go:171","msg":"trace[149543143] transaction","detail":"{read_only:false; response_revision:1915; number_of_response:1; }","duration":"160.422336ms","start":"2026-06-30T22:18:40.201811Z","end":"2026-06-30T22:18:40.362234Z","steps":["trace[149543143] 'process raft request' (duration: 160.197822ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:18:40.362275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.330943ms","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-06-30T22:18:40.362325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.827941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T22:18:40.362347Z","caller":"traceutil/trace.go:171","msg":"trace[1281668522] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1915; }","duration":"243.441804ms","start":"2026-06-30T22:18:40.118888Z","end":"2026-06-30T22:18:40.36233Z","steps":["trace[1281668522] 'agreement among raft nodes before linearized reading' (duration: 243.243651ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:18:40.362376Z","caller":"traceutil/trace.go:171","msg":"trace[516986451] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1915; }","duration":"195.908322ms","start":"2026-06-30T22:18:40.166455Z","end":"2026-06-30T22:18:40.362363Z","steps":["trace[516986451] 'agreement among raft nodes before linearized reading' (duration: 195.813481ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:18:56.050387Z","caller":"traceutil/trace.go:171","msg":"trace[281773207] transaction","detail":"{read_only:false; response_revision:2040; number_of_response:1; }","duration":"315.283651ms","start":"2026-06-30T22:18:55.735071Z","end":"2026-06-30T22:18:56.050355Z","steps":["trace[281773207] 'process raft request' (duration: 315.068948ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:18:56.050563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:18:55.73504Z","time spent":"315.437043ms","remote":"127.0.0.1:46478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T22:18:56.053778Z","caller":"traceutil/trace.go:171","msg":"trace[1478826049] transaction","detail":"{read_only:false; response_revision:2041; number_of_response:1; }","duration":"192.704489ms","start":"2026-06-30T22:18:55.861036Z","end":"2026-06-30T22:18:56.05374Z","steps":["trace[1478826049] 'process raft request' (duration: 192.574667ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:19:18.269866Z","caller":"traceutil/trace.go:171","msg":"trace[2086300404] transaction","detail":"{read_only:false; response_revision:2164; number_of_response:1; }","duration":"109.100497ms","start":"2026-06-30T22:19:18.16073Z","end":"2026-06-30T22:19:18.26983Z","steps":["trace[2086300404] 'process raft request' (duration: 108.949995ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:19:18.740672Z","caller":"traceutil/trace.go:171","msg":"trace[242991659] linearizableReadLoop","detail":"{readStateIndex:2247; appliedIndex:2246; }","duration":"186.118878ms","start":"2026-06-30T22:19:18.554527Z","end":"2026-06-30T22:19:18.740646Z","steps":["trace[242991659] 'read index received' (duration: 172.508574ms)","trace[242991659] 'applied index is now lower than readState.Index' (duration: 13.609134ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:19:18.740893Z","caller":"traceutil/trace.go:171","msg":"trace[1657645116] transaction","detail":"{read_only:false; response_revision:2166; number_of_response:1; }","duration":"186.457822ms","start":"2026-06-30T22:19:18.554402Z","end":"2026-06-30T22:19:18.740859Z","steps":["trace[1657645116] 'process raft request' (duration: 172.620435ms)","trace[1657645116] 'compare' (duration: 13.521794ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:19:18.741083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.529603ms","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-06-30T22:19:18.741164Z","caller":"traceutil/trace.go:171","msg":"trace[1238868712] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2166; }","duration":"186.656325ms","start":"2026-06-30T22:19:18.554493Z","end":"2026-06-30T22:19:18.741149Z","steps":["trace[1238868712] 'agreement among raft nodes before linearized reading' (duration: 186.406592ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:19:18.791378Z","caller":"traceutil/trace.go:171","msg":"trace[1129159961] transaction","detail":"{read_only:false; response_revision:2167; number_of_response:1; }","duration":"236.693649ms","start":"2026-06-30T22:19:18.554662Z","end":"2026-06-30T22:19:18.791356Z","steps":["trace[1129159961] 'process raft request' (duration: 236.513447ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:19:18.791543Z","caller":"traceutil/trace.go:171","msg":"trace[519329816] transaction","detail":"{read_only:false; response_revision:2168; number_of_response:1; }","duration":"235.927439ms","start":"2026-06-30T22:19:18.555599Z","end":"2026-06-30T22:19:18.791526Z","steps":["trace[519329816] 'process raft request' (duration: 235.716847ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:19:18.791887Z","caller":"traceutil/trace.go:171","msg":"trace[1632848326] transaction","detail":"{read_only:false; response_revision:2169; number_of_response:1; }","duration":"216.799718ms","start":"2026-06-30T22:19:18.57507Z","end":"2026-06-30T22:19:18.79187Z","steps":["trace[1632848326] 'process raft request' (duration: 216.385964ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:19:18.791952Z","caller":"traceutil/trace.go:171","msg":"trace[2055485906] transaction","detail":"{read_only:false; response_revision:2170; number_of_response:1; }","duration":"165.210635ms","start":"2026-06-30T22:19:18.626722Z","end":"2026-06-30T22:19:18.791932Z","steps":["trace[2055485906] 'process raft request' (duration: 165.053413ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:19:18.792055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.427257ms","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-06-30T22:19:18.792163Z","caller":"traceutil/trace.go:171","msg":"trace[1437407703] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2170; }","duration":"237.5581ms","start":"2026-06-30T22:19:18.554584Z","end":"2026-06-30T22:19:18.792142Z","steps":["trace[1437407703] 'agreement among raft nodes before linearized reading' (duration: 237.292647ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:19:19.419015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.664241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T22:19:19.419124Z","caller":"traceutil/trace.go:171","msg":"trace[1335372918] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:2172; }","duration":"105.795703ms","start":"2026-06-30T22:19:19.313309Z","end":"2026-06-30T22:19:19.419105Z","steps":["trace[1335372918] 'count revisions from in-memory index tree' (duration: 105.5513ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:19:20.435227Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153700285208058289,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-30T22:19:20.726042Z","caller":"traceutil/trace.go:171","msg":"trace[1079004305] transaction","detail":"{read_only:false; response_revision:2173; number_of_response:1; }","duration":"917.084861ms","start":"2026-06-30T22:19:19.80893Z","end":"2026-06-30T22:19:20.726015Z","steps":["trace[1079004305] 'process raft request' (duration: 916.946679ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:19:20.726188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:19:19.808906Z","time spent":"917.212702ms","remote":"127.0.0.1:46404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8538,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T22:19:21.182195Z","caller":"traceutil/trace.go:171","msg":"trace[34846996] transaction","detail":"{read_only:false; response_revision:2174; number_of_response:1; }","duration":"973.120915ms","start":"2026-06-30T22:19:20.209048Z","end":"2026-06-30T22:19:21.182169Z","steps":["trace[34846996] 'process raft request' (duration: 955.483074ms)","trace[34846996] 'compare' (duration: 17.344567ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:19:21.182339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:19:20.209021Z","time spent":"973.249006ms","remote":"127.0.0.1:46478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T22:19:21.182652Z","caller":"traceutil/trace.go:171","msg":"trace[1067501576] linearizableReadLoop","detail":"{readStateIndex:2256; appliedIndex:2254; }","duration":"1.247992022s","start":"2026-06-30T22:19:19.934646Z","end":"2026-06-30T22:19:21.182638Z","steps":["trace[1067501576] 'read index received' (duration: 791.331397ms)","trace[1067501576] 'applied index is now lower than readState.Index' (duration: 456.659855ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:19:21.18272Z","caller":"traceutil/trace.go:171","msg":"trace[949380618] transaction","detail":"{read_only:false; response_revision:2175; number_of_response:1; }","duration":"682.067306ms","start":"2026-06-30T22:19:20.500645Z","end":"2026-06-30T22:19:21.182712Z","steps":["trace[949380618] 'process raft request' (duration: 681.486619ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:19:21.182773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:19:20.500613Z","time spent":"682.126157ms","remote":"127.0.0.1:46478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T22:19:21.18292Z","caller":"traceutil/trace.go:171","msg":"trace[786727291] transaction","detail":"{read_only:false; response_revision:2176; number_of_response:1; }","duration":"661.793273ms","start":"2026-06-30T22:19:20.521118Z","end":"2026-06-30T22:19:21.182911Z","steps":["trace[786727291] 'process raft request' (duration: 661.47869ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:19:21.182973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:19:20.521098Z","time spent":"661.850134ms","remote":"127.0.0.1:46478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T22:19:21.184135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.24948062s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-06-30T22:19:21.184193Z","caller":"traceutil/trace.go:171","msg":"trace[274312617] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2176; }","duration":"1.249569751s","start":"2026-06-30T22:19:19.934611Z","end":"2026-06-30T22:19:21.18418Z","steps":["trace[274312617] 'agreement among raft nodes before linearized reading' (duration: 1.248484458s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:19:21.184227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:19:19.934596Z","time spent":"1.249623592s","remote":"127.0.0.1:46478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":553,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"warn","ts":"2026-06-30T22:19:21.185128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.247850271s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-30T22:19:21.185191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.402267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-30T22:19:21.185197Z","caller":"traceutil/trace.go:171","msg":"trace[578465148] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:2177; }","duration":"1.247939301s","start":"2026-06-30T22:19:19.937237Z","end":"2026-06-30T22:19:21.185177Z","steps":["trace[578465148] 'agreement among raft nodes before linearized reading' (duration: 1.2478307s)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:19:21.185242Z","caller":"traceutil/trace.go:171","msg":"trace[1633597211] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2177; }","duration":"388.479158ms","start":"2026-06-30T22:19:20.796755Z","end":"2026-06-30T22:19:21.185234Z","steps":["trace[1633597211] 'agreement among raft nodes before linearized reading' (duration: 388.365797ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:19:21.185262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:19:20.796745Z","time spent":"388.512618ms","remote":"127.0.0.1:46478","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-06-30T22:19:21.185269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:19:19.937229Z","time spent":"1.248027482s","remote":"127.0.0.1:46606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"warn","ts":"2026-06-30T22:19:21.185335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.125678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T22:19:21.185426Z","caller":"traceutil/trace.go:171","msg":"trace[1590991228] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:2177; }","duration":"461.28504ms","start":"2026-06-30T22:19:20.724122Z","end":"2026-06-30T22:19:21.185407Z","steps":["trace[1590991228] 'agreement among raft nodes before linearized reading' (duration: 461.108778ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:19:21.185475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:19:20.724102Z","time spent":"461.363371ms","remote":"127.0.0.1:46404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":30,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"warn","ts":"2026-06-30T22:19:21.185492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.772063ms","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-06-30T22:19:21.185511Z","caller":"traceutil/trace.go:171","msg":"trace[1348882409] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2177; }","duration":"359.818164ms","start":"2026-06-30T22:19:20.825688Z","end":"2026-06-30T22:19:21.185506Z","steps":["trace[1348882409] 'agreement among raft nodes before linearized reading' (duration: 359.761374ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:19:21.185529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:19:20.825675Z","time spent":"359.849505ms","remote":"127.0.0.1:46478","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-06-30T22:19:21.185576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"911.199412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"warn","ts":"2026-06-30T22:19:21.18564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.590889ms","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-06-30T22:19:21.185662Z","caller":"traceutil/trace.go:171","msg":"trace[1723318513] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2177; }","duration":"378.635039ms","start":"2026-06-30T22:19:20.807022Z","end":"2026-06-30T22:19:21.185657Z","steps":["trace[1723318513] 'agreement among raft nodes before linearized reading' (duration: 378.578908ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:19:21.185681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:19:20.807009Z","time spent":"378.6658ms","remote":"127.0.0.1:46478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-30T22:19:21.185788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.183336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-06-30T22:19:21.185786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.976636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-30T22:19:21.185812Z","caller":"traceutil/trace.go:171","msg":"trace[1213157216] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2177; }","duration":"379.224767ms","start":"2026-06-30T22:19:20.80658Z","end":"2026-06-30T22:19:21.185805Z","steps":["trace[1213157216] 'agreement among raft nodes before linearized reading' (duration: 379.168706ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:19:21.185847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:19:20.80657Z","time spent":"379.273257ms","remote":"127.0.0.1:37690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-30T22:19:21.185889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.947547ms","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-06-30T22:19:21.185922Z","caller":"traceutil/trace.go:171","msg":"trace[279648090] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2177; }","duration":"441.018947ms","start":"2026-06-30T22:19:20.744896Z","end":"2026-06-30T22:19:21.185915Z","steps":["trace[279648090] 'agreement among raft nodes before linearized reading' (duration: 440.941506ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:19:21.185959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:19:20.744877Z","time spent":"441.070128ms","remote":"127.0.0.1:46478","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-06-30T22:19:21.185958Z","caller":"traceutil/trace.go:171","msg":"trace[175507795] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2177; }","duration":"911.270633ms","start":"2026-06-30T22:19:20.274338Z","end":"2026-06-30T22:19:21.185609Z","steps":["trace[175507795] 'agreement among raft nodes before linearized reading' (duration: 911.160601ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:19:21.185819Z","caller":"traceutil/trace.go:171","msg":"trace[1978595583] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2177; }","duration":"390.052136ms","start":"2026-06-30T22:19:20.795758Z","end":"2026-06-30T22:19:21.18581Z","steps":["trace[1978595583] 'agreement among raft nodes before linearized reading' (duration: 389.927794ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:19:21.186012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:19:20.274325Z","time spent":"911.673108ms","remote":"127.0.0.1:46478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":577,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-06-30T22:19:21.186031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:19:20.795736Z","time spent":"390.2863ms","remote":"127.0.0.1:46478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-30T22:19:21.185434Z","caller":"traceutil/trace.go:171","msg":"trace[1340012822] transaction","detail":"{read_only:false; response_revision:2177; number_of_response:1; }","duration":"388.545458ms","start":"2026-06-30T22:19:20.79688Z","end":"2026-06-30T22:19:21.185426Z","steps":["trace[1340012822] 'process raft request' (duration: 388.104453ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:19:21.186169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:19:20.796867Z","time spent":"389.246167ms","remote":"127.0.0.1:46478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T22:19:21.185472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"733.084638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T22:19:21.186308Z","caller":"traceutil/trace.go:171","msg":"trace[477303222] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:2177; }","duration":"733.955488ms","start":"2026-06-30T22:19:20.452345Z","end":"2026-06-30T22:19:21.1863Z","steps":["trace[477303222] 'agreement among raft nodes before linearized reading' (duration: 733.084547ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:19:21.186334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:19:20.45233Z","time spent":"733.996288ms","remote":"127.0.0.1:46478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":14,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"info","ts":"2026-06-30T22:19:21.675514Z","caller":"traceutil/trace.go:171","msg":"trace[2043901863] transaction","detail":"{read_only:false; response_revision:2180; number_of_response:1; }","duration":"485.037811ms","start":"2026-06-30T22:19:21.190448Z","end":"2026-06-30T22:19:21.675486Z","steps":["trace[2043901863] 'process raft request' (duration: 484.916419ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:19:21.675562Z","caller":"traceutil/trace.go:171","msg":"trace[2093789080] transaction","detail":"{read_only:false; response_revision:2179; number_of_response:1; }","duration":"485.134471ms","start":"2026-06-30T22:19:21.190396Z","end":"2026-06-30T22:19:21.67553Z","steps":["trace[2093789080] 'process raft request' (duration: 481.126774ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:19:21.675689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:19:21.190437Z","time spent":"485.160762ms","remote":"127.0.0.1:46478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T22:19:21.675705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:19:21.190379Z","time spent":"485.250494ms","remote":"127.0.0.1:46478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T22:19:21.67643Z","caller":"traceutil/trace.go:171","msg":"trace[1231092486] transaction","detail":"{read_only:false; response_revision:2181; number_of_response:1; }","duration":"485.938681ms","start":"2026-06-30T22:19:21.190479Z","end":"2026-06-30T22:19:21.676418Z","steps":["trace[1231092486] 'process raft request' (duration: 484.97134ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:19:21.676501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:19:21.190473Z","time spent":"485.993412ms","remote":"127.0.0.1:46478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T22:19:21.676749Z","caller":"traceutil/trace.go:171","msg":"trace[1928366230] transaction","detail":"{read_only:false; response_revision:2182; number_of_response:1; }","duration":"486.008242ms","start":"2026-06-30T22:19:21.190728Z","end":"2026-06-30T22:19:21.676737Z","steps":["trace[1928366230] 'process raft request' (duration: 485.427205ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:19:21.676872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:19:21.190722Z","time spent":"486.057412ms","remote":"127.0.0.1:46478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T22:19:21.677008Z","caller":"traceutil/trace.go:171","msg":"trace[2031306534] linearizableReadLoop","detail":"{readStateIndex:2266; appliedIndex:2260; }","duration":"179.089228ms","start":"2026-06-30T22:19:21.497907Z","end":"2026-06-30T22:19:21.676997Z","steps":["trace[2031306534] 'read index received' (duration: 173.551062ms)","trace[2031306534] 'applied index is now lower than readState.Index' (duration: 5.537406ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:19:21.677029Z","caller":"traceutil/trace.go:171","msg":"trace[130779938] transaction","detail":"{read_only:false; response_revision:2183; number_of_response:1; }","duration":"486.156234ms","start":"2026-06-30T22:19:21.190767Z","end":"2026-06-30T22:19:21.676923Z","steps":["trace[130779938] 'process raft request' (duration: 485.864391ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:19:21.677226Z","caller":"traceutil/trace.go:171","msg":"trace[981317105] transaction","detail":"{read_only:false; response_revision:2184; number_of_response:1; }","duration":"486.081833ms","start":"2026-06-30T22:19:21.191082Z","end":"2026-06-30T22:19:21.677164Z","steps":["trace[981317105] 'process raft request' (duration: 485.622477ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:19:21.677287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:19:21.190763Z","time spent":"486.415127ms","remote":"127.0.0.1:46478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T22:19:21.677389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:19:21.191076Z","time spent":"486.231045ms","remote":"127.0.0.1:46478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T22:19:21.677135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.23019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T22:19:21.677739Z","caller":"traceutil/trace.go:171","msg":"trace[1122408955] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2184; }","duration":"179.819806ms","start":"2026-06-30T22:19:21.497862Z","end":"2026-06-30T22:19:21.677681Z","steps":["trace[1122408955] 'agreement among raft nodes before linearized reading' (duration: 179.180849ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:20:08.994302Z","caller":"traceutil/trace.go:171","msg":"trace[1935105333] linearizableReadLoop","detail":"{readStateIndex:2634; appliedIndex:2633; }","duration":"460.737614ms","start":"2026-06-30T22:20:08.533545Z","end":"2026-06-30T22:20:08.994283Z","steps":["trace[1935105333] 'read index received' (duration: 460.689194ms)","trace[1935105333] 'applied index is now lower than readState.Index' (duration: 47.24µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:20:08.994427Z","caller":"traceutil/trace.go:171","msg":"trace[1934150561] transaction","detail":"{read_only:false; response_revision:2542; number_of_response:1; }","duration":"574.449061ms","start":"2026-06-30T22:20:08.419967Z","end":"2026-06-30T22:20:08.994416Z","steps":["trace[1934150561] 'process raft request' (duration: 574.184628ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:20:08.994517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:20:08.419957Z","time spent":"574.495591ms","remote":"127.0.0.1:46478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T22:20:08.994747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.204036ms","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-06-30T22:20:08.994874Z","caller":"traceutil/trace.go:171","msg":"trace[97441553] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2542; }","duration":"428.389007ms","start":"2026-06-30T22:20:08.566458Z","end":"2026-06-30T22:20:08.994847Z","steps":["trace[97441553] 'agreement among raft nodes before linearized reading' (duration: 428.176105ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:20:08.994937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:20:08.566442Z","time spent":"428.481979ms","remote":"127.0.0.1:37596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-06-30T22:20:08.994973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.436922ms","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-06-30T22:20:08.995014Z","caller":"traceutil/trace.go:171","msg":"trace[1982080597] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2542; }","duration":"461.530793ms","start":"2026-06-30T22:20:08.533474Z","end":"2026-06-30T22:20:08.995005Z","steps":["trace[1982080597] 'agreement among raft nodes before linearized reading' (duration: 461.417282ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:20:08.995037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:20:08.533449Z","time spent":"461.584003ms","remote":"127.0.0.1:46428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1392,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"warn","ts":"2026-06-30T22:20:08.995101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.199075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-30T22:20:08.995099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.098242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T22:20:08.995143Z","caller":"traceutil/trace.go:171","msg":"trace[660288970] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:2542; }","duration":"426.263015ms","start":"2026-06-30T22:20:08.568868Z","end":"2026-06-30T22:20:08.995131Z","steps":["trace[660288970] 'agreement among raft nodes before linearized reading' (duration: 426.193465ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:20:08.995164Z","caller":"traceutil/trace.go:171","msg":"trace[1211330181] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:2542; }","duration":"211.239024ms","start":"2026-06-30T22:20:08.783909Z","end":"2026-06-30T22:20:08.995148Z","steps":["trace[1211330181] 'agreement among raft nodes before linearized reading' (duration: 211.115612ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:20:08.995169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:20:08.568854Z","time spent":"426.308386ms","remote":"127.0.0.1:37534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true "} {"level":"warn","ts":"2026-06-30T22:20:41.711003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.565308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T22:20:41.711133Z","caller":"traceutil/trace.go:171","msg":"trace[738232119] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2719; }","duration":"213.74196ms","start":"2026-06-30T22:20:41.49734Z","end":"2026-06-30T22:20:41.711082Z","steps":["trace[738232119] 'range keys from in-memory index tree' (duration: 213.438837ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:20:41.711254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.376442ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T22:20:41.711371Z","caller":"traceutil/trace.go:171","msg":"trace[747644195] transaction","detail":"{read_only:false; response_revision:2720; number_of_response:1; }","duration":"213.182355ms","start":"2026-06-30T22:20:41.498167Z","end":"2026-06-30T22:20:41.711349Z","steps":["trace[747644195] 'process raft request' (duration: 44.617811ms)","trace[747644195] 'compare' (duration: 168.24367ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:20:41.718501Z","caller":"traceutil/trace.go:171","msg":"trace[1812033065] transaction","detail":"{read_only:false; response_revision:2721; number_of_response:1; }","duration":"219.389966ms","start":"2026-06-30T22:20:41.499086Z","end":"2026-06-30T22:20:41.718476Z","steps":["trace[1812033065] 'process raft request' (duration: 219.209784ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:20:41.718881Z","caller":"traceutil/trace.go:171","msg":"trace[419395523] transaction","detail":"{read_only:false; response_revision:2722; number_of_response:1; }","duration":"219.649918ms","start":"2026-06-30T22:20:41.499179Z","end":"2026-06-30T22:20:41.718829Z","steps":["trace[419395523] 'process raft request' (duration: 219.247194ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:24:30.678269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.20954ms","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-06-30T22:24:30.678403Z","caller":"traceutil/trace.go:171","msg":"trace[872051998] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4616; }","duration":"530.413734ms","start":"2026-06-30T22:24:30.147963Z","end":"2026-06-30T22:24:30.678377Z","steps":["trace[872051998] 'range keys from in-memory index tree' (duration: 530.112808ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:24:30.678461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:24:30.147934Z","time spent":"530.515416ms","remote":"127.0.0.1:46660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-06-30T22:24:30.67846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.069039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T22:24:30.678559Z","caller":"traceutil/trace.go:171","msg":"trace[166117126] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4616; }","duration":"511.253552ms","start":"2026-06-30T22:24:30.16728Z","end":"2026-06-30T22:24:30.678533Z","steps":["trace[166117126] 'range keys from in-memory index tree' (duration: 510.901316ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:24:30.678599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:24:30.167246Z","time spent":"511.343954ms","remote":"127.0.0.1:46216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-30T22:24:30.678553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.801939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T22:24:30.678782Z","caller":"traceutil/trace.go:171","msg":"trace[894932460] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4616; }","duration":"181.119705ms","start":"2026-06-30T22:24:30.497655Z","end":"2026-06-30T22:24:30.678775Z","steps":["trace[894932460] 'range keys from in-memory index tree' (duration: 180.683647ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:24:37.155727Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5153700285208064468,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-30T22:24:37.187962Z","caller":"traceutil/trace.go:171","msg":"trace[926412655] transaction","detail":"{read_only:false; response_revision:4664; number_of_response:1; }","duration":"541.257779ms","start":"2026-06-30T22:24:36.646677Z","end":"2026-06-30T22:24:37.187935Z","steps":["trace[926412655] 'process raft request' (duration: 541.105246ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:24:37.188126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:24:36.646662Z","time spent":"541.382282ms","remote":"127.0.0.1:46286","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T22:24:37.383609Z","caller":"traceutil/trace.go:171","msg":"trace[1831208610] linearizableReadLoop","detail":"{readStateIndex:4844; appliedIndex:4839; }","duration":"728.523721ms","start":"2026-06-30T22:24:36.655066Z","end":"2026-06-30T22:24:37.38359Z","steps":["trace[1831208610] 'read index received' (duration: 532.750032ms)","trace[1831208610] 'applied index is now lower than readState.Index' (duration: 195.772849ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:24:37.38371Z","caller":"traceutil/trace.go:171","msg":"trace[179619292] transaction","detail":"{read_only:false; response_revision:4666; number_of_response:1; }","duration":"653.999126ms","start":"2026-06-30T22:24:36.729701Z","end":"2026-06-30T22:24:37.3837Z","steps":["trace[179619292] 'process raft request' (duration: 653.778542ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:24:37.383831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:24:36.729672Z","time spent":"654.080507ms","remote":"127.0.0.1:46478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T22:24:37.384056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"728.974039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-06-30T22:24:37.384102Z","caller":"traceutil/trace.go:171","msg":"trace[1761320642] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4668; }","duration":"729.02856ms","start":"2026-06-30T22:24:36.65506Z","end":"2026-06-30T22:24:37.384088Z","steps":["trace[1761320642] 'agreement among raft nodes before linearized reading' (duration: 728.881287ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:24:37.384088Z","caller":"traceutil/trace.go:171","msg":"trace[441642171] transaction","detail":"{read_only:false; response_revision:4667; number_of_response:1; }","duration":"652.710352ms","start":"2026-06-30T22:24:36.731347Z","end":"2026-06-30T22:24:37.384057Z","steps":["trace[441642171] 'process raft request' (duration: 652.176312ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:24:37.384139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:24:36.655051Z","time spent":"729.081081ms","remote":"127.0.0.1:46374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1958,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"warn","ts":"2026-06-30T22:24:37.384253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:24:36.731336Z","time spent":"652.831994ms","remote":"127.0.0.1:46478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T22:24:37.384275Z","caller":"traceutil/trace.go:171","msg":"trace[1617410336] transaction","detail":"{read_only:false; response_revision:4665; number_of_response:1; }","duration":"729.182673ms","start":"2026-06-30T22:24:36.655065Z","end":"2026-06-30T22:24:37.384248Z","steps":["trace[1617410336] 'process raft request' (duration: 728.280296ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:24:37.384413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:24:36.655054Z","time spent":"729.281505ms","remote":"127.0.0.1:46414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13281,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T22:24:37.38471Z","caller":"traceutil/trace.go:171","msg":"trace[2094440013] transaction","detail":"{read_only:false; response_revision:4668; number_of_response:1; }","duration":"607.301088ms","start":"2026-06-30T22:24:36.776727Z","end":"2026-06-30T22:24:37.384028Z","steps":["trace[2094440013] 'process raft request' (duration: 606.832469ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:24:37.384927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:24:36.776718Z","time spent":"608.023391ms","remote":"127.0.0.1:46478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T22:24:37.410534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.809512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T22:24:37.410614Z","caller":"traceutil/trace.go:171","msg":"trace[2055917894] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:4670; }","duration":"296.945885ms","start":"2026-06-30T22:24:37.113651Z","end":"2026-06-30T22:24:37.410596Z","steps":["trace[2055917894] 'agreement among raft nodes before linearized reading' (duration: 296.798972ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:24:37.410685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"638.914754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-06-30T22:24:37.410749Z","caller":"traceutil/trace.go:171","msg":"trace[384273458] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:4670; }","duration":"639.017106ms","start":"2026-06-30T22:24:36.771718Z","end":"2026-06-30T22:24:37.410735Z","steps":["trace[384273458] 'agreement among raft nodes before linearized reading' (duration: 638.808952ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:24:37.41078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:24:36.771709Z","time spent":"639.065027ms","remote":"127.0.0.1:46478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":553,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"info","ts":"2026-06-30T22:24:37.913758Z","caller":"traceutil/trace.go:171","msg":"trace[1299640279] linearizableReadLoop","detail":"{readStateIndex:4859; appliedIndex:4858; }","duration":"177.680273ms","start":"2026-06-30T22:24:37.736051Z","end":"2026-06-30T22:24:37.913732Z","steps":["trace[1299640279] 'read index received' (duration: 177.410698ms)","trace[1299640279] 'applied index is now lower than readState.Index' (duration: 268.445µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:24:37.91383Z","caller":"traceutil/trace.go:171","msg":"trace[929494447] transaction","detail":"{read_only:false; response_revision:4683; number_of_response:1; }","duration":"249.894571ms","start":"2026-06-30T22:24:37.663904Z","end":"2026-06-30T22:24:37.913798Z","steps":["trace[929494447] 'process raft request' (duration: 249.672577ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:24:37.914032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.971419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"warn","ts":"2026-06-30T22:24:37.914012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.349329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T22:24:37.914086Z","caller":"traceutil/trace.go:171","msg":"trace[1249191164] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4683; }","duration":"178.089951ms","start":"2026-06-30T22:24:37.735982Z","end":"2026-06-30T22:24:37.914072Z","steps":["trace[1249191164] 'agreement among raft nodes before linearized reading' (duration: 177.888678ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:24:37.914103Z","caller":"traceutil/trace.go:171","msg":"trace[1728310952] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:4683; }","duration":"149.495551ms","start":"2026-06-30T22:24:37.764588Z","end":"2026-06-30T22:24:37.914084Z","steps":["trace[1728310952] 'agreement among raft nodes before linearized reading' (duration: 149.322507ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:24:38.122904Z","caller":"traceutil/trace.go:171","msg":"trace[98375705] transaction","detail":"{read_only:false; response_revision:4684; number_of_response:1; }","duration":"201.532461ms","start":"2026-06-30T22:24:37.921342Z","end":"2026-06-30T22:24:38.122875Z","steps":["trace[98375705] 'process raft request' (duration: 113.509083ms)","trace[98375705] 'compare' (duration: 87.865525ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:24:38.127064Z","caller":"traceutil/trace.go:171","msg":"trace[1965029667] transaction","detail":"{read_only:false; response_revision:4685; number_of_response:1; }","duration":"205.229109ms","start":"2026-06-30T22:24:37.921818Z","end":"2026-06-30T22:24:38.127047Z","steps":["trace[1965029667] 'process raft request' (duration: 205.068976ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:24:38.12732Z","caller":"traceutil/trace.go:171","msg":"trace[893703289] linearizableReadLoop","detail":"{readStateIndex:4863; appliedIndex:4859; }","duration":"202.641811ms","start":"2026-06-30T22:24:37.924654Z","end":"2026-06-30T22:24:38.127296Z","steps":["trace[893703289] 'read index received' (duration: 110.211961ms)","trace[893703289] 'applied index is now lower than readState.Index' (duration: 92.42894ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:24:38.127448Z","caller":"traceutil/trace.go:171","msg":"trace[953614402] transaction","detail":"{read_only:false; response_revision:4687; number_of_response:1; }","duration":"205.473863ms","start":"2026-06-30T22:24:37.921957Z","end":"2026-06-30T22:24:38.12743Z","steps":["trace[953614402] 'process raft request' (duration: 205.240129ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:24:38.127497Z","caller":"traceutil/trace.go:171","msg":"trace[777688600] transaction","detail":"{read_only:false; response_revision:4686; number_of_response:1; }","duration":"205.622136ms","start":"2026-06-30T22:24:37.921863Z","end":"2026-06-30T22:24:38.127485Z","steps":["trace[777688600] 'process raft request' (duration: 205.126427ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:24:38.127549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.875976ms","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-06-30T22:24:38.127597Z","caller":"traceutil/trace.go:171","msg":"trace[1957723953] 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:4687; }","duration":"202.969757ms","start":"2026-06-30T22:24:37.924615Z","end":"2026-06-30T22:24:38.127584Z","steps":["trace[1957723953] 'agreement among raft nodes before linearized reading' (duration: 202.775903ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:24:41.971418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.333392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-06-30T22:24:41.971495Z","caller":"traceutil/trace.go:171","msg":"trace[1701362353] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4784; }","duration":"295.418934ms","start":"2026-06-30T22:24:41.676057Z","end":"2026-06-30T22:24:41.971476Z","steps":["trace[1701362353] 'range keys from in-memory index tree' (duration: 295.205409ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:24:42.972123Z","caller":"traceutil/trace.go:171","msg":"trace[1488613844] transaction","detail":"{read_only:false; response_revision:4791; number_of_response:1; }","duration":"262.391915ms","start":"2026-06-30T22:24:42.709713Z","end":"2026-06-30T22:24:42.972105Z","steps":["trace[1488613844] 'process raft request' (duration: 262.283343ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:24:45.778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.300968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ad3f9651-95e1-4035-a217-92cefbac7a56\" ","response":"range_response_count:1 size:3952"} {"level":"info","ts":"2026-06-30T22:24:45.778089Z","caller":"traceutil/trace.go:171","msg":"trace[631293591] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ad3f9651-95e1-4035-a217-92cefbac7a56; range_end:; response_count:1; response_revision:4809; }","duration":"391.449831ms","start":"2026-06-30T22:24:45.386619Z","end":"2026-06-30T22:24:45.778068Z","steps":["trace[631293591] 'range keys from in-memory index tree' (duration: 391.116755ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:24:45.77816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:24:45.386596Z","time spent":"391.552682ms","remote":"127.0.0.1:46414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3975,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ad3f9651-95e1-4035-a217-92cefbac7a56\" "} {"level":"warn","ts":"2026-06-30T22:24:45.778462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"907.270995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T22:24:45.778494Z","caller":"traceutil/trace.go:171","msg":"trace[352621837] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:4809; }","duration":"907.356247ms","start":"2026-06-30T22:24:44.871129Z","end":"2026-06-30T22:24:45.778485Z","steps":["trace[352621837] 'count revisions from in-memory index tree' (duration: 907.154853ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:24:45.778523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:24:44.871101Z","time spent":"907.413557ms","remote":"127.0.0.1:46538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":26,"response size":30,"request content":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true "} {"level":"info","ts":"2026-06-30T22:24:45.780028Z","caller":"traceutil/trace.go:171","msg":"trace[1296391373] linearizableReadLoop","detail":"{readStateIndex:4990; appliedIndex:4987; }","duration":"325.145624ms","start":"2026-06-30T22:24:45.454866Z","end":"2026-06-30T22:24:45.780011Z","steps":["trace[1296391373] 'read index received' (duration: 266.07566ms)","trace[1296391373] 'applied index is now lower than readState.Index' (duration: 59.069144ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:24:45.78022Z","caller":"traceutil/trace.go:171","msg":"trace[1364481235] transaction","detail":"{read_only:false; response_revision:4810; number_of_response:1; }","duration":"366.301433ms","start":"2026-06-30T22:24:45.413904Z","end":"2026-06-30T22:24:45.780205Z","steps":["trace[1364481235] 'process raft request' (duration: 306.888232ms)","trace[1364481235] 'compare' (duration: 56.976586ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:24:45.780393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:24:45.413815Z","time spent":"366.481466ms","remote":"127.0.0.1:46478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T22:24:45.780517Z","caller":"traceutil/trace.go:171","msg":"trace[2070063894] transaction","detail":"{read_only:false; response_revision:4812; number_of_response:1; }","duration":"362.29459ms","start":"2026-06-30T22:24:45.418184Z","end":"2026-06-30T22:24:45.780479Z","steps":["trace[2070063894] 'process raft request' (duration: 361.790811ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:24:45.780609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:24:45.418175Z","time spent":"362.388281ms","remote":"127.0.0.1:46478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T22:24:45.780766Z","caller":"traceutil/trace.go:171","msg":"trace[1542674363] transaction","detail":"{read_only:false; response_revision:4811; number_of_response:1; }","duration":"363.507742ms","start":"2026-06-30T22:24:45.417247Z","end":"2026-06-30T22:24:45.780755Z","steps":["trace[1542674363] 'process raft request' (duration: 362.651796ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:24:45.780853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:24:45.417229Z","time spent":"363.566423ms","remote":"127.0.0.1:46478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T22:24:45.780958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.090161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T22:24:45.780999Z","caller":"traceutil/trace.go:171","msg":"trace[304041198] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:4812; }","duration":"326.169553ms","start":"2026-06-30T22:24:45.454819Z","end":"2026-06-30T22:24:45.780988Z","steps":["trace[304041198] 'agreement among raft nodes before linearized reading' (duration: 326.048111ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:24:45.78103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:24:45.454804Z","time spent":"326.218444ms","remote":"127.0.0.1:46346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"warn","ts":"2026-06-30T22:24:45.781148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.616189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T22:24:45.78118Z","caller":"traceutil/trace.go:171","msg":"trace[417185702] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4812; }","duration":"283.667479ms","start":"2026-06-30T22:24:45.497502Z","end":"2026-06-30T22:24:45.78117Z","steps":["trace[417185702] 'agreement among raft nodes before linearized reading' (duration: 283.618169ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:24:45.781362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.112476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-30T22:24:45.781393Z","caller":"traceutil/trace.go:171","msg":"trace[299091428] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4812; }","duration":"186.166656ms","start":"2026-06-30T22:24:45.595217Z","end":"2026-06-30T22:24:45.781383Z","steps":["trace[299091428] 'agreement among raft nodes before linearized reading' (duration: 186.071195ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:24:45.781623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.824895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-30T22:24:45.78165Z","caller":"traceutil/trace.go:171","msg":"trace[2096483277] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4812; }","duration":"144.898515ms","start":"2026-06-30T22:24:45.636743Z","end":"2026-06-30T22:24:45.781642Z","steps":["trace[2096483277] 'agreement among raft nodes before linearized reading' (duration: 144.814683ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:24:45.781816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.284251ms","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":"warn","ts":"2026-06-30T22:24:45.781886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.086219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-30T22:24:45.781918Z","caller":"traceutil/trace.go:171","msg":"trace[562345626] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4812; }","duration":"151.430994ms","start":"2026-06-30T22:24:45.630459Z","end":"2026-06-30T22:24:45.78189Z","steps":["trace[562345626] 'agreement among raft nodes before linearized reading' (duration: 151.137249ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:24:45.781968Z","caller":"traceutil/trace.go:171","msg":"trace[1307939991] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4812; }","duration":"250.204381ms","start":"2026-06-30T22:24:45.531742Z","end":"2026-06-30T22:24:45.781946Z","steps":["trace[1307939991] 'agreement among raft nodes before linearized reading' (duration: 249.933206ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:24:45.781961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.263517ms","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-06-30T22:24:45.782053Z","caller":"traceutil/trace.go:171","msg":"trace[1472816261] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4812; }","duration":"258.3894ms","start":"2026-06-30T22:24:45.523625Z","end":"2026-06-30T22:24:45.782014Z","steps":["trace[1472816261] 'agreement among raft nodes before linearized reading' (duration: 258.148595ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:24:45.782255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.388366ms","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-06-30T22:24:45.78235Z","caller":"traceutil/trace.go:171","msg":"trace[2003561616] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4812; }","duration":"194.506369ms","start":"2026-06-30T22:24:45.58783Z","end":"2026-06-30T22:24:45.782336Z","steps":["trace[2003561616] 'agreement among raft nodes before linearized reading' (duration: 194.311525ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:24:45.784993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.572687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T22:24:45.785066Z","caller":"traceutil/trace.go:171","msg":"trace[1903255742] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:4812; }","duration":"228.69459ms","start":"2026-06-30T22:24:45.556357Z","end":"2026-06-30T22:24:45.785051Z","steps":["trace[1903255742] 'agreement among raft nodes before linearized reading' (duration: 228.521197ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:24:46.301457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.82571ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T22:24:46.301698Z","caller":"traceutil/trace.go:171","msg":"trace[980819179] transaction","detail":"{read_only:false; response_revision:4826; number_of_response:1; }","duration":"310.631117ms","start":"2026-06-30T22:24:45.991026Z","end":"2026-06-30T22:24:46.301657Z","steps":["trace[980819179] 'process raft request' (duration: 112.461891ms)","trace[980819179] 'compare' (duration: 197.634966ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:24:46.301749Z","caller":"traceutil/trace.go:171","msg":"trace[547633735] transaction","detail":"{read_only:false; response_revision:4827; number_of_response:1; }","duration":"103.819343ms","start":"2026-06-30T22:24:46.197902Z","end":"2026-06-30T22:24:46.301721Z","steps":["trace[547633735] 'process raft request' (duration: 103.715031ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:24:46.301747Z","caller":"traceutil/trace.go:171","msg":"trace[1621914949] linearizableReadLoop","detail":"{readStateIndex:5005; appliedIndex:5004; }","duration":"295.501171ms","start":"2026-06-30T22:24:46.006217Z","end":"2026-06-30T22:24:46.301718Z","steps":["trace[1621914949] 'read index received' (duration: 97.201313ms)","trace[1621914949] 'applied index is now lower than readState.Index' (duration: 198.297218ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:24:46.301885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T22:24:45.991001Z","time spent":"310.773279ms","remote":"127.0.0.1:38344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2249,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T22:24:46.301982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.396774ms","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-06-30T22:24:46.302022Z","caller":"traceutil/trace.go:171","msg":"trace[1927617803] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4827; }","duration":"233.503656ms","start":"2026-06-30T22:24:46.068506Z","end":"2026-06-30T22:24:46.30201Z","steps":["trace[1927617803] 'agreement among raft nodes before linearized reading' (duration: 233.368594ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:24:46.30199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.073255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T22:24:46.302074Z","caller":"traceutil/trace.go:171","msg":"trace[1644565890] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:4827; }","duration":"165.276438ms","start":"2026-06-30T22:24:46.136777Z","end":"2026-06-30T22:24:46.302053Z","steps":["trace[1644565890] 'agreement among raft nodes before linearized reading' (duration: 165.137816ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:24:46.302104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.841937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3243"} {"level":"info","ts":"2026-06-30T22:24:46.302208Z","caller":"traceutil/trace.go:171","msg":"trace[1782329172] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4827; }","duration":"295.97974ms","start":"2026-06-30T22:24:46.006199Z","end":"2026-06-30T22:24:46.302178Z","steps":["trace[1782329172] 'agreement among raft nodes before linearized reading' (duration: 295.610284ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:24:46.727344Z","caller":"traceutil/trace.go:171","msg":"trace[147154222] linearizableReadLoop","detail":"{readStateIndex:5019; appliedIndex:5018; }","duration":"231.248246ms","start":"2026-06-30T22:24:46.496059Z","end":"2026-06-30T22:24:46.727307Z","steps":["trace[147154222] 'read index received' (duration: 131.320873ms)","trace[147154222] 'applied index is now lower than readState.Index' (duration: 99.926153ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:24:46.727358Z","caller":"traceutil/trace.go:171","msg":"trace[970941373] transaction","detail":"{read_only:false; response_revision:4840; number_of_response:1; }","duration":"234.658337ms","start":"2026-06-30T22:24:46.492658Z","end":"2026-06-30T22:24:46.727316Z","steps":["trace[970941373] 'process raft request' (duration: 134.636562ms)","trace[970941373] 'compare' (duration: 99.818031ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:24:46.727702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.611812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-06-30T22:24:46.728018Z","caller":"traceutil/trace.go:171","msg":"trace[765284220] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4840; }","duration":"231.844176ms","start":"2026-06-30T22:24:46.496042Z","end":"2026-06-30T22:24:46.727886Z","steps":["trace[765284220] 'agreement among raft nodes before linearized reading' (duration: 231.399248ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:24:46.728126Z","caller":"traceutil/trace.go:171","msg":"trace[157690896] transaction","detail":"{read_only:false; response_revision:4841; number_of_response:1; }","duration":"228.316333ms","start":"2026-06-30T22:24:46.499739Z","end":"2026-06-30T22:24:46.728056Z","steps":["trace[157690896] 'process raft request' (duration: 227.674771ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:24:46.728926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.849131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2206973"} {"level":"info","ts":"2026-06-30T22:24:46.728975Z","caller":"traceutil/trace.go:171","msg":"trace[1010402113] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4841; }","duration":"164.969353ms","start":"2026-06-30T22:24:46.563994Z","end":"2026-06-30T22:24:46.728963Z","steps":["trace[1010402113] 'agreement among raft nodes before linearized reading' (duration: 163.942934ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:24:46.9854Z","caller":"traceutil/trace.go:171","msg":"trace[1405813543] linearizableReadLoop","detail":"{readStateIndex:5022; appliedIndex:5021; }","duration":"183.51345ms","start":"2026-06-30T22:24:46.801859Z","end":"2026-06-30T22:24:46.985372Z","steps":["trace[1405813543] 'read index received' (duration: 87.948075ms)","trace[1405813543] 'applied index is now lower than readState.Index' (duration: 95.564155ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:24:46.985548Z","caller":"traceutil/trace.go:171","msg":"trace[1652996267] transaction","detail":"{read_only:false; response_revision:4843; number_of_response:1; }","duration":"183.997469ms","start":"2026-06-30T22:24:46.801533Z","end":"2026-06-30T22:24:46.98553Z","steps":["trace[1652996267] 'process raft request' (duration: 88.254781ms)","trace[1652996267] 'compare' (duration: 95.439962ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:24:46.985847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.950078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:3958"} {"level":"info","ts":"2026-06-30T22:24:46.985964Z","caller":"traceutil/trace.go:171","msg":"trace[963240068] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4843; }","duration":"184.090311ms","start":"2026-06-30T22:24:46.801843Z","end":"2026-06-30T22:24:46.985933Z","steps":["trace[963240068] 'agreement among raft nodes before linearized reading' (duration: 183.762925ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:24:47.035726Z","caller":"traceutil/trace.go:171","msg":"trace[1742995730] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4844; }","duration":"229.467812ms","start":"2026-06-30T22:24:46.806234Z","end":"2026-06-30T22:24:47.035701Z","steps":["trace[1742995730] 'process raft request' (duration: 229.388381ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:24:47.035749Z","caller":"traceutil/trace.go:171","msg":"trace[1416065290] transaction","detail":"{read_only:false; response_revision:4844; number_of_response:1; }","duration":"230.031002ms","start":"2026-06-30T22:24:46.805684Z","end":"2026-06-30T22:24:47.035715Z","steps":["trace[1416065290] 'process raft request' (duration: 229.769638ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:24:47.036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.02356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-06-30T22:24:47.036084Z","caller":"traceutil/trace.go:171","msg":"trace[1268790384] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4844; }","duration":"215.136052ms","start":"2026-06-30T22:24:46.820924Z","end":"2026-06-30T22:24:47.03606Z","steps":["trace[1268790384] 'agreement among raft nodes before linearized reading' (duration: 214.872407ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:24:47.169718Z","caller":"traceutil/trace.go:171","msg":"trace[2110368008] linearizableReadLoop","detail":"{readStateIndex:5026; appliedIndex:5025; }","duration":"119.494683ms","start":"2026-06-30T22:24:47.050199Z","end":"2026-06-30T22:24:47.169694Z","steps":["trace[2110368008] 'read index received' (duration: 80.203342ms)","trace[2110368008] 'applied index is now lower than readState.Index' (duration: 39.290231ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:24:47.169765Z","caller":"traceutil/trace.go:171","msg":"trace[1916657963] transaction","detail":"{read_only:false; response_revision:4846; number_of_response:1; }","duration":"123.835122ms","start":"2026-06-30T22:24:47.045896Z","end":"2026-06-30T22:24:47.169731Z","steps":["trace[1916657963] 'process raft request' (duration: 84.388857ms)","trace[1916657963] 'compare' (duration: 39.277812ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:24:47.170066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.092179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls-sh2h7\" ","response":"range_response_count:1 size:2596"} {"level":"warn","ts":"2026-06-30T22:24:47.170055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.745583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-06-30T22:24:47.170134Z","caller":"traceutil/trace.go:171","msg":"trace[1914068833] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls-sh2h7; range_end:; response_count:1; response_revision:4846; }","duration":"128.213802ms","start":"2026-06-30T22:24:47.041903Z","end":"2026-06-30T22:24:47.170117Z","steps":["trace[1914068833] 'agreement among raft nodes before linearized reading' (duration: 127.894376ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:24:47.170162Z","caller":"traceutil/trace.go:171","msg":"trace[135627095] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4846; }","duration":"127.905536ms","start":"2026-06-30T22:24:47.042232Z","end":"2026-06-30T22:24:47.170137Z","steps":["trace[135627095] 'agreement among raft nodes before linearized reading' (duration: 127.527529ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:24:47.170974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.486221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-06-30T22:24:47.171112Z","caller":"traceutil/trace.go:171","msg":"trace[2130732616] transaction","detail":"{read_only:false; response_revision:4847; number_of_response:1; }","duration":"116.740963ms","start":"2026-06-30T22:24:47.05433Z","end":"2026-06-30T22:24:47.17107Z","steps":["trace[2130732616] 'process raft request' (duration: 116.477268ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:24:47.171361Z","caller":"traceutil/trace.go:171","msg":"trace[1920094199] transaction","detail":"{read_only:false; response_revision:4848; number_of_response:1; }","duration":"116.483198ms","start":"2026-06-30T22:24:47.054853Z","end":"2026-06-30T22:24:47.171336Z","steps":["trace[1920094199] 'process raft request' (duration: 116.01783ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:24:47.17118Z","caller":"traceutil/trace.go:171","msg":"trace[885572429] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4848; }","duration":"115.724174ms","start":"2026-06-30T22:24:47.055441Z","end":"2026-06-30T22:24:47.171165Z","steps":["trace[885572429] 'agreement among raft nodes before linearized reading' (duration: 115.46507ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:24:54.145204Z","caller":"traceutil/trace.go:171","msg":"trace[203780647] transaction","detail":"{read_only:false; response_revision:4930; number_of_response:1; }","duration":"148.655749ms","start":"2026-06-30T22:24:53.996483Z","end":"2026-06-30T22:24:54.145139Z","steps":["trace[203780647] 'process raft request' (duration: 148.402184ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:24:54.145226Z","caller":"traceutil/trace.go:171","msg":"trace[988760287] transaction","detail":"{read_only:false; response_revision:4931; number_of_response:1; }","duration":"148.554657ms","start":"2026-06-30T22:24:53.996601Z","end":"2026-06-30T22:24:54.145155Z","steps":["trace[988760287] 'process raft request' (duration: 148.360363ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:24:54.145648Z","caller":"traceutil/trace.go:171","msg":"trace[545108535] transaction","detail":"{read_only:false; response_revision:4929; number_of_response:1; }","duration":"148.959024ms","start":"2026-06-30T22:24:53.996052Z","end":"2026-06-30T22:24:54.145011Z","steps":["trace[545108535] 'process raft request' (duration: 148.611398ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:25:35.619607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.633785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T22:25:35.619725Z","caller":"traceutil/trace.go:171","msg":"trace[1077565768] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5277; }","duration":"122.810718ms","start":"2026-06-30T22:25:35.496878Z","end":"2026-06-30T22:25:35.619688Z","steps":["trace[1077565768] 'range keys from in-memory index tree' (duration: 122.498683ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:26:11.531422Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2878} {"level":"info","ts":"2026-06-30T22:26:11.640538Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2878,"took":"106.90523ms","hash":4095348955,"current-db-size-bytes":54185984,"current-db-size":"54 MB","current-db-size-in-use-bytes":29175808,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-30T22:26:11.640614Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4095348955,"revision":2878,"compact-revision":-1} {"level":"info","ts":"2026-06-30T22:28:21.259025Z","caller":"traceutil/trace.go:171","msg":"trace[612091510] linearizableReadLoop","detail":"{readStateIndex:6685; appliedIndex:6684; }","duration":"137.128017ms","start":"2026-06-30T22:28:21.121864Z","end":"2026-06-30T22:28:21.258992Z","steps":["trace[612091510] 'read index received' (duration: 89.350879ms)","trace[612091510] 'applied index is now lower than readState.Index' (duration: 47.775988ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:28:21.259189Z","caller":"traceutil/trace.go:171","msg":"trace[135047612] transaction","detail":"{read_only:false; response_revision:6455; number_of_response:1; }","duration":"141.600338ms","start":"2026-06-30T22:28:21.117574Z","end":"2026-06-30T22:28:21.259175Z","steps":["trace[135047612] 'process raft request' (duration: 93.74345ms)","trace[135047612] 'compare' (duration: 47.535954ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:28:21.25937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.163008ms","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-06-30T22:28:21.259455Z","caller":"traceutil/trace.go:171","msg":"trace[1447784078] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6455; }","duration":"137.2966ms","start":"2026-06-30T22:28:21.122139Z","end":"2026-06-30T22:28:21.259436Z","steps":["trace[1447784078] 'agreement among raft nodes before linearized reading' (duration: 137.157278ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T22:28:21.25987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.499439ms","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-06-30T22:28:21.259868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.988129ms","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-06-30T22:28:21.259915Z","caller":"traceutil/trace.go:171","msg":"trace[1239926682] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6455; }","duration":"136.56502ms","start":"2026-06-30T22:28:21.123338Z","end":"2026-06-30T22:28:21.259903Z","steps":["trace[1239926682] 'agreement among raft nodes before linearized reading' (duration: 136.497839ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:28:21.259929Z","caller":"traceutil/trace.go:171","msg":"trace[1565108919] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:6455; }","duration":"138.110651ms","start":"2026-06-30T22:28:21.121801Z","end":"2026-06-30T22:28:21.259912Z","steps":["trace[1565108919] 'agreement among raft nodes before linearized reading' (duration: 137.992479ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:28:21.407431Z","caller":"traceutil/trace.go:171","msg":"trace[1643471286] transaction","detail":"{read_only:false; response_revision:6457; number_of_response:1; }","duration":"141.446656ms","start":"2026-06-30T22:28:21.265949Z","end":"2026-06-30T22:28:21.407396Z","steps":["trace[1643471286] 'process raft request' (duration: 141.255764ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:28:21.407596Z","caller":"traceutil/trace.go:171","msg":"trace[924843402] transaction","detail":"{read_only:false; response_revision:6458; number_of_response:1; }","duration":"141.336196ms","start":"2026-06-30T22:28:21.266231Z","end":"2026-06-30T22:28:21.407567Z","steps":["trace[924843402] 'process raft request' (duration: 141.024281ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:28:21.408446Z","caller":"traceutil/trace.go:171","msg":"trace[1461679952] transaction","detail":"{read_only:false; response_revision:6456; number_of_response:1; }","duration":"142.886176ms","start":"2026-06-30T22:28:21.265097Z","end":"2026-06-30T22:28:21.407983Z","steps":["trace[1461679952] 'process raft request' (duration: 99.327077ms)","trace[1461679952] 'compare' (duration: 42.619116ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:28:49.073856Z","caller":"traceutil/trace.go:171","msg":"trace[1838260550] transaction","detail":"{read_only:false; response_revision:6652; number_of_response:1; }","duration":"142.372152ms","start":"2026-06-30T22:28:48.931452Z","end":"2026-06-30T22:28:49.073824Z","steps":["trace[1838260550] 'process raft request' (duration: 142.151909ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:28:49.621834Z","caller":"traceutil/trace.go:171","msg":"trace[514298443] transaction","detail":"{read_only:false; response_revision:6656; number_of_response:1; }","duration":"206.3862ms","start":"2026-06-30T22:28:49.415422Z","end":"2026-06-30T22:28:49.621808Z","steps":["trace[514298443] 'process raft request' (duration: 181.799097ms)","trace[514298443] 'compare' (duration: 24.081896ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:28:49.639169Z","caller":"traceutil/trace.go:171","msg":"trace[162980569] linearizableReadLoop","detail":"{readStateIndex:6895; appliedIndex:6893; }","duration":"142.041367ms","start":"2026-06-30T22:28:49.497101Z","end":"2026-06-30T22:28:49.639142Z","steps":["trace[162980569] 'read index received' (duration: 100.075518ms)","trace[162980569] 'applied index is now lower than readState.Index' (duration: 41.964389ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T22:28:49.639353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.23013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T22:28:49.639389Z","caller":"traceutil/trace.go:171","msg":"trace[819150268] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6656; }","duration":"142.314811ms","start":"2026-06-30T22:28:49.497064Z","end":"2026-06-30T22:28:49.639379Z","steps":["trace[819150268] 'agreement among raft nodes before linearized reading' (duration: 142.229679ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:28:49.744973Z","caller":"traceutil/trace.go:171","msg":"trace[224708180] transaction","detail":"{read_only:false; response_revision:6658; number_of_response:1; }","duration":"100.053907ms","start":"2026-06-30T22:28:49.644898Z","end":"2026-06-30T22:28:49.744952Z","steps":["trace[224708180] 'process raft request' (duration: 79.968374ms)","trace[224708180] 'compare' (duration: 19.915621ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T22:28:49.745274Z","caller":"traceutil/trace.go:171","msg":"trace[969924257] transaction","detail":"{read_only:false; response_revision:6659; number_of_response:1; }","duration":"100.27258ms","start":"2026-06-30T22:28:49.644984Z","end":"2026-06-30T22:28:49.745257Z","steps":["trace[969924257] 'process raft request' (duration: 99.925885ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T22:31:11.540852Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5547} {"level":"info","ts":"2026-06-30T22:31:11.637791Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5547,"took":"95.317553ms","hash":3654186159,"current-db-size-bytes":54185984,"current-db-size":"54 MB","current-db-size-in-use-bytes":18296832,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-30T22:31:11.638158Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3654186159,"revision":5547,"compact-revision":2878}