{"level":"warn","ts":"2026-05-27T13:46:01.106262Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-27T13:46:01.106356Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.206: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.19.213.206:2380","--initial-cluster=instance=https://199.19.213.206:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.206:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.206:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-27T13:46:01.106438Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-27T13:46:01.106453Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.206:2380"]} {"level":"info","ts":"2026-05-27T13:46:01.106478Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-27T13:46:01.107344Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.206:2379"]} {"level":"info","ts":"2026-05-27T13:46:01.107437Z","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.19.213.206:2380"],"listen-peer-urls":["https://199.19.213.206:2380"],"advertise-client-urls":["https://199.19.213.206:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.206:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.206:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-27T13:46:01.113047Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.287673ms"} {"level":"info","ts":"2026-05-27T13:46:01.122672Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b696d7a595057bfe","cluster-id":"9b00ba6f3f3b7ac2"} {"level":"info","ts":"2026-05-27T13:46:01.122789Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b696d7a595057bfe switched to configuration voters=()"} {"level":"info","ts":"2026-05-27T13:46:01.12293Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b696d7a595057bfe became follower at term 0"} {"level":"info","ts":"2026-05-27T13:46:01.123029Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b696d7a595057bfe [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-27T13:46:01.123092Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b696d7a595057bfe became follower at term 1"} {"level":"info","ts":"2026-05-27T13:46:01.12319Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b696d7a595057bfe switched to configuration voters=(13156940467579223038)"} {"level":"warn","ts":"2026-05-27T13:46:01.130211Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-27T13:46:01.132302Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-27T13:46:01.134183Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-27T13:46:01.137471Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b696d7a595057bfe","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-27T13:46:01.137651Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b696d7a595057bfe","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-27T13:46:01.137895Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-27T13:46:01.138001Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-27T13:46:01.138016Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-27T13:46:01.141883Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b696d7a595057bfe switched to configuration voters=(13156940467579223038)"} {"level":"info","ts":"2026-05-27T13:46:01.142924Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9b00ba6f3f3b7ac2","local-member-id":"b696d7a595057bfe","added-peer-id":"b696d7a595057bfe","added-peer-peer-urls":["https://199.19.213.206:2380"]} {"level":"info","ts":"2026-05-27T13:46:01.145476Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-27T13:46:01.145636Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.206:2380"} {"level":"info","ts":"2026-05-27T13:46:01.145688Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.206:2380"} {"level":"info","ts":"2026-05-27T13:46:01.145922Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b696d7a595057bfe","initial-advertise-peer-urls":["https://199.19.213.206:2380"],"listen-peer-urls":["https://199.19.213.206:2380"],"advertise-client-urls":["https://199.19.213.206:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.206:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-27T13:46:01.145976Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-27T13:46:01.724113Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b696d7a595057bfe is starting a new election at term 1"} {"level":"info","ts":"2026-05-27T13:46:01.724187Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b696d7a595057bfe became pre-candidate at term 1"} {"level":"info","ts":"2026-05-27T13:46:01.724212Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b696d7a595057bfe received MsgPreVoteResp from b696d7a595057bfe at term 1"} {"level":"info","ts":"2026-05-27T13:46:01.724233Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b696d7a595057bfe became candidate at term 2"} {"level":"info","ts":"2026-05-27T13:46:01.724246Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b696d7a595057bfe received MsgVoteResp from b696d7a595057bfe at term 2"} {"level":"info","ts":"2026-05-27T13:46:01.724322Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b696d7a595057bfe became leader at term 2"} {"level":"info","ts":"2026-05-27T13:46:01.724339Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b696d7a595057bfe elected leader b696d7a595057bfe at term 2"} {"level":"info","ts":"2026-05-27T13:46:01.725529Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b696d7a595057bfe","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.206:2379]}","request-path":"/0/members/b696d7a595057bfe/attributes","cluster-id":"9b00ba6f3f3b7ac2","publish-timeout":"7s"} {"level":"info","ts":"2026-05-27T13:46:01.725575Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T13:46:01.725861Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T13:46:01.726502Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T13:46:01.726544Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-27T13:46:01.726612Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-27T13:46:01.727593Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9b00ba6f3f3b7ac2","local-member-id":"b696d7a595057bfe","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T13:46:01.727744Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T13:46:01.727828Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T13:46:01.73021Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.206:2379"} {"level":"info","ts":"2026-05-27T13:46:01.7314Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-27T13:46:39.971718Z","caller":"traceutil/trace.go:171","msg":"trace[665650079] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"326.519477ms","start":"2026-05-27T13:46:39.645142Z","end":"2026-05-27T13:46:39.971661Z","steps":["trace[665650079] 'process raft request' (duration: 326.306414ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:39.972714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:39.645122Z","time spent":"326.70345ms","remote":"127.0.0.1:37150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:46:39.983659Z","caller":"traceutil/trace.go:171","msg":"trace[1063563559] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"337.066472ms","start":"2026-05-27T13:46:39.64657Z","end":"2026-05-27T13:46:39.983636Z","steps":["trace[1063563559] 'process raft request' (duration: 336.854059ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:39.983764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:39.64655Z","time spent":"337.164934ms","remote":"127.0.0.1:37150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:46:39.983925Z","caller":"traceutil/trace.go:171","msg":"trace[925711737] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"322.291449ms","start":"2026-05-27T13:46:39.661531Z","end":"2026-05-27T13:46:39.983823Z","steps":["trace[925711737] 'process raft request' (duration: 322.082006ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:46:39.983934Z","caller":"traceutil/trace.go:171","msg":"trace[994858287] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"321.138923ms","start":"2026-05-27T13:46:39.662787Z","end":"2026-05-27T13:46:39.983925Z","steps":["trace[994858287] 'process raft request' (duration: 320.853578ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:46:39.983919Z","caller":"traceutil/trace.go:171","msg":"trace[1270605346] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"318.050432ms","start":"2026-05-27T13:46:39.665844Z","end":"2026-05-27T13:46:39.983895Z","steps":["trace[1270605346] 'process raft request' (duration: 317.854709ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:46:39.98397Z","caller":"traceutil/trace.go:171","msg":"trace[1266567675] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"155.192833ms","start":"2026-05-27T13:46:39.828766Z","end":"2026-05-27T13:46:39.983959Z","steps":["trace[1266567675] 'process raft request' (duration: 155.150153ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:39.983993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:39.661523Z","time spent":"322.428521ms","remote":"127.0.0.1:37150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:46:39.984054Z","caller":"traceutil/trace.go:171","msg":"trace[121801704] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"332.59962ms","start":"2026-05-27T13:46:39.651446Z","end":"2026-05-27T13:46:39.984045Z","steps":["trace[121801704] 'process raft request' (duration: 332.061303ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:46:39.984068Z","caller":"traceutil/trace.go:171","msg":"trace[1382295620] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"322.656024ms","start":"2026-05-27T13:46:39.661404Z","end":"2026-05-27T13:46:39.98406Z","steps":["trace[1382295620] 'process raft request' (duration: 322.131207ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:46:39.984082Z","caller":"traceutil/trace.go:171","msg":"trace[1932543514] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"317.242699ms","start":"2026-05-27T13:46:39.666831Z","end":"2026-05-27T13:46:39.984074Z","steps":["trace[1932543514] 'process raft request' (duration: 316.902935ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:39.984107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:39.651422Z","time spent":"332.663291ms","remote":"127.0.0.1:37150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:46:39.984136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:39.661386Z","time spent":"322.699294ms","remote":"127.0.0.1:37150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:46:39.984156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:39.666819Z","time spent":"317.282322ms","remote":"127.0.0.1:37150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:46:39.983975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:39.662774Z","time spent":"321.179563ms","remote":"127.0.0.1:37150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:46:39.984222Z","caller":"traceutil/trace.go:171","msg":"trace[331267823] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"293.450473ms","start":"2026-05-27T13:46:39.690763Z","end":"2026-05-27T13:46:39.984214Z","steps":["trace[331267823] 'process raft request' (duration: 293.106267ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:46:39.984262Z","caller":"traceutil/trace.go:171","msg":"trace[1940817741] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"310.293264ms","start":"2026-05-27T13:46:39.673959Z","end":"2026-05-27T13:46:39.984253Z","steps":["trace[1940817741] 'process raft request' (duration: 309.828838ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:39.984292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:39.665817Z","time spent":"318.448206ms","remote":"127.0.0.1:37150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:46:39.984222Z","caller":"traceutil/trace.go:171","msg":"trace[1432140726] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"308.206125ms","start":"2026-05-27T13:46:39.676Z","end":"2026-05-27T13:46:39.984206Z","steps":["trace[1432140726] 'process raft request' (duration: 307.8274ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:39.984437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:39.67598Z","time spent":"308.438439ms","remote":"127.0.0.1:37150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:46:39.984329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:39.673949Z","time spent":"310.345964ms","remote":"127.0.0.1:37150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T13:46:46.516548Z","caller":"traceutil/trace.go:171","msg":"trace[528442369] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"387.074362ms","start":"2026-05-27T13:46:46.129446Z","end":"2026-05-27T13:46:46.516521Z","steps":["trace[528442369] 'process raft request' (duration: 386.482814ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:46.516844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:46.12941Z","time spent":"387.207803ms","remote":"127.0.0.1:37192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:46:47.035741Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8934752887500581012,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-27T13:46:47.146152Z","caller":"traceutil/trace.go:171","msg":"trace[908309944] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"612.946873ms","start":"2026-05-27T13:46:46.533181Z","end":"2026-05-27T13:46:47.146127Z","steps":["trace[908309944] 'process raft request' (duration: 612.774161ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:47.146418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:46.533137Z","time spent":"613.152246ms","remote":"127.0.0.1:37272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:46:47.156494Z","caller":"traceutil/trace.go:171","msg":"trace[250127270] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:667; }","duration":"621.449078ms","start":"2026-05-27T13:46:46.535017Z","end":"2026-05-27T13:46:47.156466Z","steps":["trace[250127270] 'read index received' (duration: 610.977036ms)","trace[250127270] 'applied index is now lower than readState.Index' (duration: 10.470672ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:46:47.156903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.848383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:46:47.156965Z","caller":"traceutil/trace.go:171","msg":"trace[1303856277] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:642; }","duration":"621.958185ms","start":"2026-05-27T13:46:46.534995Z","end":"2026-05-27T13:46:47.156953Z","steps":["trace[1303856277] 'agreement among raft nodes before linearized reading' (duration: 621.572579ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:47.157011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:46.534982Z","time spent":"622.018455ms","remote":"127.0.0.1:37092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-27T13:46:47.157325Z","caller":"traceutil/trace.go:171","msg":"trace[464194560] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"578.014229ms","start":"2026-05-27T13:46:46.579299Z","end":"2026-05-27T13:46:47.157313Z","steps":["trace[464194560] 'process raft request' (duration: 577.042976ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:47.157419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:46.579273Z","time spent":"578.08988ms","remote":"127.0.0.1:37602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:46:48.060757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.123851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-27T13:46:48.060826Z","caller":"traceutil/trace.go:171","msg":"trace[973863961] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:642; }","duration":"553.241553ms","start":"2026-05-27T13:46:47.50757Z","end":"2026-05-27T13:46:48.060812Z","steps":["trace[973863961] 'range keys from in-memory index tree' (duration: 552.99671ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:48.060858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:47.507548Z","time spent":"553.302344ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-27T13:46:48.061001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"834.501203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-27T13:46:48.061345Z","caller":"traceutil/trace.go:171","msg":"trace[1435074698] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:642; }","duration":"834.888579ms","start":"2026-05-27T13:46:47.226431Z","end":"2026-05-27T13:46:48.061319Z","steps":["trace[1435074698] 'range keys from in-memory index tree' (duration: 834.360392ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:48.061399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:47.226407Z","time spent":"834.976709ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-27T13:46:48.061798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.035067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-27T13:46:48.061844Z","caller":"traceutil/trace.go:171","msg":"trace[1486847755] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:642; }","duration":"535.102597ms","start":"2026-05-27T13:46:47.526728Z","end":"2026-05-27T13:46:48.06183Z","steps":["trace[1486847755] 'range keys from in-memory index tree' (duration: 534.120875ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:48.061817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.055358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-05-27T13:46:48.061876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:47.526716Z","time spent":"535.151219ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-27T13:46:48.061918Z","caller":"traceutil/trace.go:171","msg":"trace[287434925] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:642; }","duration":"721.207679ms","start":"2026-05-27T13:46:47.340684Z","end":"2026-05-27T13:46:48.061891Z","steps":["trace[287434925] 'range keys from in-memory index tree' (duration: 720.891744ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:48.061971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:47.340664Z","time spent":"721.29447ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-27T13:46:48.550355Z","caller":"traceutil/trace.go:171","msg":"trace[80278095] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"983.604973ms","start":"2026-05-27T13:46:47.56667Z","end":"2026-05-27T13:46:48.550275Z","steps":["trace[80278095] 'process raft request' (duration: 975.843498ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:48.550666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:47.566645Z","time spent":"983.829146ms","remote":"127.0.0.1:37192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:46:48.555889Z","caller":"traceutil/trace.go:171","msg":"trace[1206679037] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"861.326996ms","start":"2026-05-27T13:46:47.694546Z","end":"2026-05-27T13:46:48.555873Z","steps":["trace[1206679037] 'process raft request' (duration: 860.879041ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:48.555987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:47.69452Z","time spent":"861.405857ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:46:48.556077Z","caller":"traceutil/trace.go:171","msg":"trace[656118940] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"489.290038ms","start":"2026-05-27T13:46:48.06678Z","end":"2026-05-27T13:46:48.55607Z","steps":["trace[656118940] 'process raft request' (duration: 488.744771ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:48.556122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:48.066759Z","time spent":"489.338288ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:46:48.556202Z","caller":"traceutil/trace.go:171","msg":"trace[1824784062] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"489.41459ms","start":"2026-05-27T13:46:48.066778Z","end":"2026-05-27T13:46:48.556193Z","steps":["trace[1824784062] 'process raft request' (duration: 488.785161ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:48.556247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:48.066722Z","time spent":"489.50156ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:46:48.556333Z","caller":"traceutil/trace.go:171","msg":"trace[817894316] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"488.622378ms","start":"2026-05-27T13:46:48.067702Z","end":"2026-05-27T13:46:48.556324Z","steps":["trace[817894316] 'process raft request' (duration: 487.891588ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:48.556374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:48.06768Z","time spent":"488.672688ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:46:48.556477Z","caller":"traceutil/trace.go:171","msg":"trace[938112576] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"488.684899ms","start":"2026-05-27T13:46:48.067783Z","end":"2026-05-27T13:46:48.556468Z","steps":["trace[938112576] 'process raft request' (duration: 487.840657ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:46:48.556525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:46:48.067753Z","time spent":"488.748611ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:46:49.649528Z","caller":"traceutil/trace.go:171","msg":"trace[981717304] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"157.445006ms","start":"2026-05-27T13:46:49.492066Z","end":"2026-05-27T13:46:49.649511Z","steps":["trace[981717304] 'process raft request' (duration: 149.188655ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:46:49.649436Z","caller":"traceutil/trace.go:171","msg":"trace[1922843369] linearizableReadLoop","detail":"{readStateIndex:683; appliedIndex:681; }","duration":"120.918353ms","start":"2026-05-27T13:46:49.528492Z","end":"2026-05-27T13:46:49.649411Z","steps":["trace[1922843369] 'read index received' (duration: 791.811µs)","trace[1922843369] 'applied index is now lower than readState.Index' (duration: 120.125532ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:46:49.649709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.191216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:46:49.649795Z","caller":"traceutil/trace.go:171","msg":"trace[59406245] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:656; }","duration":"121.329788ms","start":"2026-05-27T13:46:49.52845Z","end":"2026-05-27T13:46:49.64978Z","steps":["trace[59406245] 'agreement among raft nodes before linearized reading' (duration: 121.155196ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:47:04.807608Z","caller":"traceutil/trace.go:171","msg":"trace[1878386767] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"429.35799ms","start":"2026-05-27T13:47:04.378223Z","end":"2026-05-27T13:47:04.807581Z","steps":["trace[1878386767] 'process raft request' (duration: 429.170153ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:04.807826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:04.378202Z","time spent":"429.481505ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:47:04.951657Z","caller":"traceutil/trace.go:171","msg":"trace[1455945092] linearizableReadLoop","detail":"{readStateIndex:842; appliedIndex:840; }","duration":"423.626445ms","start":"2026-05-27T13:47:04.527987Z","end":"2026-05-27T13:47:04.951613Z","steps":["trace[1455945092] 'read index received' (duration: 279.542777ms)","trace[1455945092] 'applied index is now lower than readState.Index' (duration: 144.082388ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:47:04.951885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.873914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T13:47:04.951979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.223829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-27T13:47:04.952003Z","caller":"traceutil/trace.go:171","msg":"trace[413371906] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:810; }","duration":"424.032159ms","start":"2026-05-27T13:47:04.527918Z","end":"2026-05-27T13:47:04.95195Z","steps":["trace[413371906] 'agreement among raft nodes before linearized reading' (duration: 423.865433ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:47:04.952056Z","caller":"traceutil/trace.go:171","msg":"trace[1864554125] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:810; }","duration":"312.366603ms","start":"2026-05-27T13:47:04.639676Z","end":"2026-05-27T13:47:04.952043Z","steps":["trace[1864554125] 'agreement among raft nodes before linearized reading' (duration: 312.153355ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:04.952074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:04.527894Z","time spent":"424.167514ms","remote":"127.0.0.1:37092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-27T13:47:04.952095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:04.639664Z","time spent":"312.423095ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-27T13:47:04.952165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.061823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-05-27T13:47:04.952188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.253455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.206\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-27T13:47:04.952289Z","caller":"traceutil/trace.go:171","msg":"trace[1274199220] range","detail":"{range_begin:/registry/masterleases/199.19.213.206; range_end:; response_count:1; response_revision:810; }","duration":"168.39828ms","start":"2026-05-27T13:47:04.783879Z","end":"2026-05-27T13:47:04.952277Z","steps":["trace[1274199220] 'agreement among raft nodes before linearized reading' (duration: 168.048198ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:47:04.952284Z","caller":"traceutil/trace.go:171","msg":"trace[914680098] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:810; }","duration":"312.179697ms","start":"2026-05-27T13:47:04.640047Z","end":"2026-05-27T13:47:04.952227Z","steps":["trace[914680098] 'agreement among raft nodes before linearized reading' (duration: 311.783552ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:04.952074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.829012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-27T13:47:04.952409Z","caller":"traceutil/trace.go:171","msg":"trace[1681088000] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:810; }","duration":"322.171325ms","start":"2026-05-27T13:47:04.63023Z","end":"2026-05-27T13:47:04.952401Z","steps":["trace[1681088000] 'agreement among raft nodes before linearized reading' (duration: 321.572084ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:04.952371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:04.640033Z","time spent":"312.325862ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-27T13:47:04.952452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:04.630138Z","time spent":"322.29752ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-27T13:47:04.952225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.303803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-27T13:47:04.952542Z","caller":"traceutil/trace.go:171","msg":"trace[136634447] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:810; }","duration":"319.636205ms","start":"2026-05-27T13:47:04.632883Z","end":"2026-05-27T13:47:04.952519Z","steps":["trace[136634447] 'agreement among raft nodes before linearized reading' (duration: 319.221941ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:04.952609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:04.632871Z","time spent":"319.718798ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-27T13:47:04.952641Z","caller":"traceutil/trace.go:171","msg":"trace[1608039274] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"360.706598ms","start":"2026-05-27T13:47:04.591921Z","end":"2026-05-27T13:47:04.952628Z","steps":["trace[1608039274] 'process raft request' (duration: 359.618439ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:04.952751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:04.591899Z","time spent":"360.78618ms","remote":"127.0.0.1:37324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:47:04.953055Z","caller":"traceutil/trace.go:171","msg":"trace[2047812745] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"525.642983ms","start":"2026-05-27T13:47:04.426132Z","end":"2026-05-27T13:47:04.951775Z","steps":["trace[2047812745] 'process raft request' (duration: 525.183517ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:04.953395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:04.4261Z","time spent":"527.227861ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:47:19.076811Z","caller":"traceutil/trace.go:171","msg":"trace[729903659] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"344.442058ms","start":"2026-05-27T13:47:18.732346Z","end":"2026-05-27T13:47:19.076788Z","steps":["trace[729903659] 'process raft request' (duration: 344.287603ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:19.077052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:47:18.732327Z","time spent":"344.559541ms","remote":"127.0.0.1:37566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3297,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:47:19.07942Z","caller":"traceutil/trace.go:171","msg":"trace[2114670030] linearizableReadLoop","detail":"{readStateIndex:1007; appliedIndex:1005; }","duration":"187.957181ms","start":"2026-05-27T13:47:18.891441Z","end":"2026-05-27T13:47:19.079398Z","steps":["trace[2114670030] 'read index received' (duration: 185.225494ms)","trace[2114670030] 'applied index is now lower than readState.Index' (duration: 2.730867ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:47:19.079642Z","caller":"traceutil/trace.go:171","msg":"trace[685943063] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"291.78931ms","start":"2026-05-27T13:47:18.787837Z","end":"2026-05-27T13:47:19.079626Z","steps":["trace[685943063] 'process raft request' (duration: 291.388307ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:47:19.0797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.25798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-27T13:47:19.079744Z","caller":"traceutil/trace.go:171","msg":"trace[1058855965] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:972; }","duration":"188.364043ms","start":"2026-05-27T13:47:18.891368Z","end":"2026-05-27T13:47:19.079732Z","steps":["trace[1058855965] 'agreement among raft nodes before linearized reading' (duration: 188.192957ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:47:57.079205Z","caller":"traceutil/trace.go:171","msg":"trace[2132413934] transaction","detail":"{read_only:false; response_revision:1467; number_of_response:1; }","duration":"142.323445ms","start":"2026-05-27T13:47:56.936856Z","end":"2026-05-27T13:47:57.079179Z","steps":["trace[2132413934] 'process raft request' (duration: 142.159772ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:48:23.077589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.723173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2c8f9637-0df3-438d-9290-3cfbcee8529a\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-27T13:48:23.07766Z","caller":"traceutil/trace.go:171","msg":"trace[923343283] transaction","detail":"{read_only:false; response_revision:1892; number_of_response:1; }","duration":"106.52473ms","start":"2026-05-27T13:48:22.971105Z","end":"2026-05-27T13:48:23.07763Z","steps":["trace[923343283] 'process raft request' (duration: 37.62344ms)","trace[923343283] 'compare' (duration: 68.631335ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:48:23.077697Z","caller":"traceutil/trace.go:171","msg":"trace[1715969085] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2c8f9637-0df3-438d-9290-3cfbcee8529a; range_end:; response_count:1; response_revision:1891; }","duration":"124.870646ms","start":"2026-05-27T13:48:22.952806Z","end":"2026-05-27T13:48:23.077677Z","steps":["trace[1715969085] 'range keys from in-memory index tree' (duration: 124.57698ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:48:23.275236Z","caller":"traceutil/trace.go:171","msg":"trace[1743196505] transaction","detail":"{read_only:false; response_revision:1893; number_of_response:1; }","duration":"189.896359ms","start":"2026-05-27T13:48:23.085314Z","end":"2026-05-27T13:48:23.275211Z","steps":["trace[1743196505] 'process raft request' (duration: 189.700124ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:48:23.948477Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8934752887500583428,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-27T13:48:23.951436Z","caller":"traceutil/trace.go:171","msg":"trace[1988523074] transaction","detail":"{read_only:false; response_revision:1894; number_of_response:1; }","duration":"503.705287ms","start":"2026-05-27T13:48:23.447692Z","end":"2026-05-27T13:48:23.951398Z","steps":["trace[1988523074] 'process raft request' (duration: 503.481542ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:48:23.951774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:48:23.447656Z","time spent":"503.914641ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:48:24.511481Z","caller":"traceutil/trace.go:171","msg":"trace[1353998665] transaction","detail":"{read_only:false; response_revision:1895; number_of_response:1; }","duration":"1.06245728s","start":"2026-05-27T13:48:23.448981Z","end":"2026-05-27T13:48:24.511439Z","steps":["trace[1353998665] 'process raft request' (duration: 1.045716652s)","trace[1353998665] 'compare' (duration: 16.410731ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:48:24.511629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:48:23.448963Z","time spent":"1.062596173s","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:48:24.511902Z","caller":"traceutil/trace.go:171","msg":"trace[1772948762] transaction","detail":"{read_only:false; response_revision:1897; number_of_response:1; }","duration":"615.071502ms","start":"2026-05-27T13:48:23.896805Z","end":"2026-05-27T13:48:24.511876Z","steps":["trace[1772948762] 'process raft request' (duration: 614.823026ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:48:24.511889Z","caller":"traceutil/trace.go:171","msg":"trace[639360092] transaction","detail":"{read_only:false; response_revision:1896; number_of_response:1; }","duration":"852.987631ms","start":"2026-05-27T13:48:23.658826Z","end":"2026-05-27T13:48:24.511813Z","steps":["trace[639360092] 'process raft request' (duration: 852.733576ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:48:24.512048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:48:23.896767Z","time spent":"615.182235ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:48:24.512145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.063896481s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-27T13:48:24.512222Z","caller":"traceutil/trace.go:171","msg":"trace[1917041509] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1897; }","duration":"1.064020604s","start":"2026-05-27T13:48:23.448187Z","end":"2026-05-27T13:48:24.512207Z","steps":["trace[1917041509] 'agreement among raft nodes before linearized reading' (duration: 1.063805659s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:48:24.512256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:48:23.448174Z","time spent":"1.064076484s","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-27T13:48:24.512251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:48:23.6588Z","time spent":"853.285717ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:48:24.51275Z","caller":"traceutil/trace.go:171","msg":"trace[1767029169] linearizableReadLoop","detail":"{readStateIndex:1973; appliedIndex:1969; }","duration":"1.063440531s","start":"2026-05-27T13:48:23.448239Z","end":"2026-05-27T13:48:24.51168Z","steps":["trace[1767029169] 'read index received' (duration: 502.972482ms)","trace[1767029169] 'applied index is now lower than readState.Index' (duration: 560.467009ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:48:24.515772Z","caller":"traceutil/trace.go:171","msg":"trace[241785928] transaction","detail":"{read_only:false; response_revision:1898; number_of_response:1; }","duration":"552.170581ms","start":"2026-05-27T13:48:23.96359Z","end":"2026-05-27T13:48:24.515761Z","steps":["trace[241785928] 'process raft request' (duration: 552.029768ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:48:24.51584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:48:23.963561Z","time spent":"552.249464ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:48:24.515966Z","caller":"traceutil/trace.go:171","msg":"trace[1068340847] transaction","detail":"{read_only:false; response_revision:1899; number_of_response:1; }","duration":"488.748312ms","start":"2026-05-27T13:48:24.027197Z","end":"2026-05-27T13:48:24.515945Z","steps":["trace[1068340847] 'process raft request' (duration: 488.531508ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:48:24.516006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"869.344823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2c8f9637-0df3-438d-9290-3cfbcee8529a\" ","response":"range_response_count:1 size:3744"} {"level":"warn","ts":"2026-05-27T13:48:24.516012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.067014098s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-27T13:48:24.516043Z","caller":"traceutil/trace.go:171","msg":"trace[597685599] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2c8f9637-0df3-438d-9290-3cfbcee8529a; range_end:; response_count:1; response_revision:1899; }","duration":"869.426674ms","start":"2026-05-27T13:48:23.646608Z","end":"2026-05-27T13:48:24.516035Z","steps":["trace[597685599] 'agreement among raft nodes before linearized reading' (duration: 869.285152ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:48:24.51606Z","caller":"traceutil/trace.go:171","msg":"trace[1786748421] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1899; }","duration":"1.06710468s","start":"2026-05-27T13:48:23.448944Z","end":"2026-05-27T13:48:24.516048Z","steps":["trace[1786748421] 'agreement among raft nodes before linearized reading' (duration: 1.066946117s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:48:24.516069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:48:23.646585Z","time spent":"869.479636ms","remote":"127.0.0.1:37272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3768,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2c8f9637-0df3-438d-9290-3cfbcee8529a\" "} {"level":"warn","ts":"2026-05-27T13:48:24.516093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:48:23.448923Z","time spent":"1.067164151s","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-27T13:48:24.5162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.819487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T13:48:24.51622Z","caller":"traceutil/trace.go:171","msg":"trace[1410437298] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1899; }","duration":"375.886888ms","start":"2026-05-27T13:48:24.140328Z","end":"2026-05-27T13:48:24.516215Z","steps":["trace[1410437298] 'agreement among raft nodes before linearized reading' (duration: 375.848788ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:48:24.516235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:48:24.140296Z","time spent":"375.93378ms","remote":"127.0.0.1:37450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":31,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-27T13:48:24.51624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.066412495s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-05-27T13:48:24.516244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.044085595s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-27T13:48:24.516259Z","caller":"traceutil/trace.go:171","msg":"trace[111193227] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1899; }","duration":"1.066477156s","start":"2026-05-27T13:48:23.449774Z","end":"2026-05-27T13:48:24.516251Z","steps":["trace[111193227] 'agreement among raft nodes before linearized reading' (duration: 1.066418725s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:48:24.516276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:48:23.449748Z","time spent":"1.066523868s","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-27T13:48:24.51628Z","caller":"traceutil/trace.go:171","msg":"trace[1598208385] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1899; }","duration":"1.044172857s","start":"2026-05-27T13:48:23.472096Z","end":"2026-05-27T13:48:24.516269Z","steps":["trace[1598208385] 'agreement among raft nodes before linearized reading' (duration: 1.044002033s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:48:24.516042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:48:24.027168Z","time spent":"488.845444ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:48:24.516323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:48:23.472076Z","time spent":"1.044221027s","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-05-27T13:48:24.516499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"988.792669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:48:24.516526Z","caller":"traceutil/trace.go:171","msg":"trace[1968669106] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1899; }","duration":"988.913761ms","start":"2026-05-27T13:48:23.527606Z","end":"2026-05-27T13:48:24.51652Z","steps":["trace[1968669106] 'agreement among raft nodes before linearized reading' (duration: 988.848979ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:48:24.516545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:48:23.527571Z","time spent":"988.970221ms","remote":"127.0.0.1:37092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-27T13:48:30.110074Z","caller":"traceutil/trace.go:171","msg":"trace[372312991] transaction","detail":"{read_only:false; response_revision:1958; number_of_response:1; }","duration":"131.934175ms","start":"2026-05-27T13:48:29.978121Z","end":"2026-05-27T13:48:30.110055Z","steps":["trace[372312991] 'process raft request' (duration: 131.801843ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:48:50.786104Z","caller":"traceutil/trace.go:171","msg":"trace[1543316696] transaction","detail":"{read_only:false; response_revision:2093; number_of_response:1; }","duration":"167.821107ms","start":"2026-05-27T13:48:50.618254Z","end":"2026-05-27T13:48:50.786076Z","steps":["trace[1543316696] 'process raft request' (duration: 167.618022ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:48:50.786294Z","caller":"traceutil/trace.go:171","msg":"trace[392470916] linearizableReadLoop","detail":"{readStateIndex:2177; appliedIndex:2175; }","duration":"137.879292ms","start":"2026-05-27T13:48:50.648381Z","end":"2026-05-27T13:48:50.78626Z","steps":["trace[392470916] 'read index received' (duration: 137.505396ms)","trace[392470916] 'applied index is now lower than readState.Index' (duration: 371.456µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:48:50.786332Z","caller":"traceutil/trace.go:171","msg":"trace[314865105] transaction","detail":"{read_only:false; response_revision:2094; number_of_response:1; }","duration":"168.02262ms","start":"2026-05-27T13:48:50.618282Z","end":"2026-05-27T13:48:50.786304Z","steps":["trace[314865105] 'process raft request' (duration: 167.753844ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:48:50.786656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.25872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-05-27T13:48:50.786673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.024156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-27T13:48:50.787344Z","caller":"traceutil/trace.go:171","msg":"trace[1155051054] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2094; }","duration":"138.754509ms","start":"2026-05-27T13:48:50.648569Z","end":"2026-05-27T13:48:50.787324Z","steps":["trace[1155051054] 'agreement among raft nodes before linearized reading' (duration: 137.881192ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:48:50.786701Z","caller":"traceutil/trace.go:171","msg":"trace[992878700] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2094; }","duration":"138.349501ms","start":"2026-05-27T13:48:50.64834Z","end":"2026-05-27T13:48:50.78669Z","steps":["trace[992878700] 'agreement among raft nodes before linearized reading' (duration: 138.073426ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:48:50.786778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.669479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-27T13:48:50.787729Z","caller":"traceutil/trace.go:171","msg":"trace[346514362] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2094; }","duration":"137.638618ms","start":"2026-05-27T13:48:50.650081Z","end":"2026-05-27T13:48:50.787719Z","steps":["trace[346514362] 'agreement among raft nodes before linearized reading' (duration: 136.500406ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:48:50.786837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.159848ms","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-05-27T13:48:50.786884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.563351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-27T13:48:50.788397Z","caller":"traceutil/trace.go:171","msg":"trace[1031278129] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2094; }","duration":"133.09737ms","start":"2026-05-27T13:48:50.655285Z","end":"2026-05-27T13:48:50.788382Z","steps":["trace[1031278129] 'agreement among raft nodes before linearized reading' (duration: 131.209463ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:48:50.792941Z","caller":"traceutil/trace.go:171","msg":"trace[750948833] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2094; }","duration":"106.248948ms","start":"2026-05-27T13:48:50.686649Z","end":"2026-05-27T13:48:50.792898Z","steps":["trace[750948833] 'agreement among raft nodes before linearized reading' (duration: 99.908774ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:48:51.130264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.506015ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:48:51.130362Z","caller":"traceutil/trace.go:171","msg":"trace[774394132] transaction","detail":"{read_only:false; response_revision:2095; number_of_response:1; }","duration":"336.59833ms","start":"2026-05-27T13:48:50.793749Z","end":"2026-05-27T13:48:51.130347Z","steps":["trace[774394132] 'process raft request' (duration: 118.760411ms)","trace[774394132] 'compare' (duration: 217.137436ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:48:51.130407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:48:50.793406Z","time spent":"336.978259ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:48:51.139461Z","caller":"traceutil/trace.go:171","msg":"trace[1583503298] transaction","detail":"{read_only:false; response_revision:2096; number_of_response:1; }","duration":"344.589496ms","start":"2026-05-27T13:48:50.794848Z","end":"2026-05-27T13:48:51.139437Z","steps":["trace[1583503298] 'process raft request' (duration: 344.427143ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:48:51.139667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:48:50.794831Z","time spent":"344.756319ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:48:51.140062Z","caller":"traceutil/trace.go:171","msg":"trace[1874182384] transaction","detail":"{read_only:false; response_revision:2097; number_of_response:1; }","duration":"344.831211ms","start":"2026-05-27T13:48:50.795192Z","end":"2026-05-27T13:48:51.140023Z","steps":["trace[1874182384] 'process raft request' (duration: 344.195279ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:48:51.140093Z","caller":"traceutil/trace.go:171","msg":"trace[764933571] transaction","detail":"{read_only:false; response_revision:2098; number_of_response:1; }","duration":"341.595418ms","start":"2026-05-27T13:48:50.798469Z","end":"2026-05-27T13:48:51.140065Z","steps":["trace[764933571] 'process raft request' (duration: 341.358012ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:48:51.140131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:48:50.795179Z","time spent":"344.919153ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:48:51.140195Z","caller":"traceutil/trace.go:171","msg":"trace[1113987469] transaction","detail":"{read_only:false; response_revision:2099; number_of_response:1; }","duration":"317.122532ms","start":"2026-05-27T13:48:50.823038Z","end":"2026-05-27T13:48:51.140161Z","steps":["trace[1113987469] 'process raft request' (duration: 316.963889ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:48:51.140156Z","caller":"traceutil/trace.go:171","msg":"trace[447831445] linearizableReadLoop","detail":"{readStateIndex:2181; appliedIndex:2177; }","duration":"326.730169ms","start":"2026-05-27T13:48:50.813345Z","end":"2026-05-27T13:48:51.140076Z","steps":["trace[447831445] 'read index received' (duration: 99.18637ms)","trace[447831445] 'applied index is now lower than readState.Index' (duration: 227.541509ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:48:51.140282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:48:50.798446Z","time spent":"341.714161ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:48:51.14031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.958303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:48:51.14056Z","caller":"traceutil/trace.go:171","msg":"trace[860293720] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:2099; }","duration":"327.229238ms","start":"2026-05-27T13:48:50.813314Z","end":"2026-05-27T13:48:51.140544Z","steps":["trace[860293720] 'agreement among raft nodes before linearized reading' (duration: 326.919122ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:48:51.140603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:48:50.813304Z","time spent":"327.28836ms","remote":"127.0.0.1:44888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-05-27T13:48:51.140329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:48:50.823017Z","time spent":"317.251474ms","remote":"127.0.0.1:37174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":831,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:48:51.140418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.704082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:48:51.140839Z","caller":"traceutil/trace.go:171","msg":"trace[1577240878] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:2099; }","duration":"191.164372ms","start":"2026-05-27T13:48:50.949657Z","end":"2026-05-27T13:48:51.140822Z","steps":["trace[1577240878] 'agreement among raft nodes before linearized reading' (duration: 190.714433ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:48:56.803388Z","caller":"traceutil/trace.go:171","msg":"trace[1380514454] transaction","detail":"{read_only:false; response_revision:2124; number_of_response:1; }","duration":"166.026082ms","start":"2026-05-27T13:48:56.637334Z","end":"2026-05-27T13:48:56.80336Z","steps":["trace[1380514454] 'process raft request' (duration: 160.608489ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:48:57.15609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.188262ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:48:57.156176Z","caller":"traceutil/trace.go:171","msg":"trace[2032992815] linearizableReadLoop","detail":"{readStateIndex:2210; appliedIndex:2209; }","duration":"320.982116ms","start":"2026-05-27T13:48:56.835179Z","end":"2026-05-27T13:48:57.156162Z","steps":["trace[2032992815] 'read index received' (duration: 124.51175ms)","trace[2032992815] 'applied index is now lower than readState.Index' (duration: 196.469166ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:48:57.156252Z","caller":"traceutil/trace.go:171","msg":"trace[1601783151] transaction","detail":"{read_only:false; response_revision:2126; number_of_response:1; }","duration":"349.774937ms","start":"2026-05-27T13:48:56.806466Z","end":"2026-05-27T13:48:57.156241Z","steps":["trace[1601783151] 'process raft request' (duration: 153.364101ms)","trace[1601783151] 'compare' (duration: 196.033869ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:48:57.156308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:48:56.806441Z","time spent":"349.839008ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:48:57.156525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.328143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-27T13:48:57.156602Z","caller":"traceutil/trace.go:171","msg":"trace[868558382] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2126; }","duration":"321.442874ms","start":"2026-05-27T13:48:56.83514Z","end":"2026-05-27T13:48:57.156583Z","steps":["trace[868558382] 'agreement among raft nodes before linearized reading' (duration: 321.309032ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:48:57.156638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:48:56.835124Z","time spent":"321.504957ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-05-27T13:48:58.849408Z","caller":"traceutil/trace.go:171","msg":"trace[182100972] linearizableReadLoop","detail":"{readStateIndex:2218; appliedIndex:2217; }","duration":"187.630826ms","start":"2026-05-27T13:48:58.661756Z","end":"2026-05-27T13:48:58.849387Z","steps":["trace[182100972] 'read index received' (duration: 187.537874ms)","trace[182100972] 'applied index is now lower than readState.Index' (duration: 91.692µs)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:48:58.849553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.779188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:48:58.849586Z","caller":"traceutil/trace.go:171","msg":"trace[1474863681] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:2134; }","duration":"187.859881ms","start":"2026-05-27T13:48:58.661717Z","end":"2026-05-27T13:48:58.849577Z","steps":["trace[1474863681] 'agreement among raft nodes before linearized reading' (duration: 187.750299ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:48:58.849697Z","caller":"traceutil/trace.go:171","msg":"trace[1871396063] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"200.509652ms","start":"2026-05-27T13:48:58.649158Z","end":"2026-05-27T13:48:58.849667Z","steps":["trace[1871396063] 'process raft request' (duration: 200.073173ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:49:00.031312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.733455ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:49:00.031434Z","caller":"traceutil/trace.go:171","msg":"trace[409275303] linearizableReadLoop","detail":"{readStateIndex:2221; appliedIndex:2220; }","duration":"859.219884ms","start":"2026-05-27T13:48:59.172194Z","end":"2026-05-27T13:49:00.031413Z","steps":["trace[409275303] 'read index received' (duration: 259.179343ms)","trace[409275303] 'applied index is now lower than readState.Index' (duration: 600.038841ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:49:00.031439Z","caller":"traceutil/trace.go:171","msg":"trace[1117595379] transaction","detail":"{read_only:false; response_revision:2137; number_of_response:1; }","duration":"869.04373ms","start":"2026-05-27T13:48:59.162367Z","end":"2026-05-27T13:49:00.03141Z","steps":["trace[1117595379] 'process raft request' (duration: 269.089351ms)","trace[1117595379] 'compare' (duration: 599.611423ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:49:00.031608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:48:59.162341Z","time spent":"869.193372ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:49:00.031691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"859.488409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-27T13:49:00.031749Z","caller":"traceutil/trace.go:171","msg":"trace[258892754] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2137; }","duration":"859.596101ms","start":"2026-05-27T13:48:59.172138Z","end":"2026-05-27T13:49:00.031734Z","steps":["trace[258892754] 'agreement among raft nodes before linearized reading' (duration: 859.409407ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:49:00.031802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:48:59.172117Z","time spent":"859.672722ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-05-27T13:49:00.099805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"860.838481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-27T13:49:00.099851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"762.476636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-27T13:49:00.099887Z","caller":"traceutil/trace.go:171","msg":"trace[1110287780] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2137; }","duration":"860.967352ms","start":"2026-05-27T13:48:59.238902Z","end":"2026-05-27T13:49:00.09987Z","steps":["trace[1110287780] 'agreement among raft nodes before linearized reading' (duration: 860.750808ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:49:00.09991Z","caller":"traceutil/trace.go:171","msg":"trace[1571788900] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2137; }","duration":"762.584118ms","start":"2026-05-27T13:48:59.33731Z","end":"2026-05-27T13:49:00.099894Z","steps":["trace[1571788900] 'agreement among raft nodes before linearized reading' (duration: 762.389975ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:49:00.099931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:48:59.238875Z","time spent":"861.046894ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-27T13:49:00.099958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"762.647009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"warn","ts":"2026-05-27T13:49:00.099978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"845.187854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-27T13:49:00.10002Z","caller":"traceutil/trace.go:171","msg":"trace[400316925] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2137; }","duration":"762.744412ms","start":"2026-05-27T13:48:59.33726Z","end":"2026-05-27T13:49:00.100005Z","steps":["trace[400316925] 'agreement among raft nodes before linearized reading' (duration: 762.581078ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:49:00.09995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:48:59.337285Z","time spent":"762.6561ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-27T13:49:00.100043Z","caller":"traceutil/trace.go:171","msg":"trace[1104214414] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2137; }","duration":"845.291326ms","start":"2026-05-27T13:48:59.254735Z","end":"2026-05-27T13:49:00.100027Z","steps":["trace[1104214414] 'agreement among raft nodes before linearized reading' (duration: 845.108722ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:49:00.10006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:48:59.33724Z","time spent":"762.811073ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-27T13:49:00.100087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:48:59.254718Z","time spent":"845.359946ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-27T13:49:00.361559Z","caller":"traceutil/trace.go:171","msg":"trace[1901897166] transaction","detail":"{read_only:false; response_revision:2139; number_of_response:1; }","duration":"256.843274ms","start":"2026-05-27T13:49:00.104685Z","end":"2026-05-27T13:49:00.361528Z","steps":["trace[1901897166] 'process raft request' (duration: 245.095282ms)","trace[1901897166] 'compare' (duration: 11.556948ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:49:00.361937Z","caller":"traceutil/trace.go:171","msg":"trace[1354755837] transaction","detail":"{read_only:false; response_revision:2140; number_of_response:1; }","duration":"256.630231ms","start":"2026-05-27T13:49:00.105281Z","end":"2026-05-27T13:49:00.361912Z","steps":["trace[1354755837] 'process raft request' (duration: 256.193513ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:49:00.361935Z","caller":"traceutil/trace.go:171","msg":"trace[2114598624] transaction","detail":"{read_only:false; response_revision:2141; number_of_response:1; }","duration":"256.54654ms","start":"2026-05-27T13:49:00.105367Z","end":"2026-05-27T13:49:00.361913Z","steps":["trace[2114598624] 'process raft request' (duration: 256.409247ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:50:04.963022Z","caller":"traceutil/trace.go:171","msg":"trace[1483222309] linearizableReadLoop","detail":"{readStateIndex:2690; appliedIndex:2689; }","duration":"171.463478ms","start":"2026-05-27T13:50:04.791524Z","end":"2026-05-27T13:50:04.962987Z","steps":["trace[1483222309] 'read index received' (duration: 138.38273ms)","trace[1483222309] 'applied index is now lower than readState.Index' (duration: 33.079288ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:50:04.963417Z","caller":"traceutil/trace.go:171","msg":"trace[673417569] transaction","detail":"{read_only:false; response_revision:2591; number_of_response:1; }","duration":"193.374575ms","start":"2026-05-27T13:50:04.77001Z","end":"2026-05-27T13:50:04.963385Z","steps":["trace[673417569] 'process raft request' (duration: 159.957182ms)","trace[673417569] 'compare' (duration: 32.64491ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:50:04.964035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.909244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.206\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-27T13:50:04.964191Z","caller":"traceutil/trace.go:171","msg":"trace[936231005] range","detail":"{range_begin:/registry/masterleases/199.19.213.206; range_end:; response_count:1; response_revision:2591; }","duration":"172.664056ms","start":"2026-05-27T13:50:04.791472Z","end":"2026-05-27T13:50:04.964136Z","steps":["trace[936231005] 'agreement among raft nodes before linearized reading' (duration: 171.71934ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:50:32.711898Z","caller":"traceutil/trace.go:171","msg":"trace[2102823297] transaction","detail":"{read_only:false; response_revision:2744; number_of_response:1; }","duration":"143.474626ms","start":"2026-05-27T13:50:32.568393Z","end":"2026-05-27T13:50:32.711867Z","steps":["trace[2102823297] 'process raft request' (duration: 143.256472ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:50:38.352813Z","caller":"traceutil/trace.go:171","msg":"trace[353306800] transaction","detail":"{read_only:false; response_revision:2772; number_of_response:1; }","duration":"143.233361ms","start":"2026-05-27T13:50:38.209541Z","end":"2026-05-27T13:50:38.352774Z","steps":["trace[353306800] 'process raft request' (duration: 142.994048ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:50:38.958489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.673546ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:50:38.958596Z","caller":"traceutil/trace.go:171","msg":"trace[2066613387] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2772; }","duration":"469.789357ms","start":"2026-05-27T13:50:38.488791Z","end":"2026-05-27T13:50:38.958581Z","steps":["trace[2066613387] 'range keys from in-memory index tree' (duration: 469.663556ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:50:38.959091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.055968ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:50:38.959209Z","caller":"traceutil/trace.go:171","msg":"trace[1543120567] linearizableReadLoop","detail":"{readStateIndex:2880; appliedIndex:2879; }","duration":"430.629538ms","start":"2026-05-27T13:50:38.528559Z","end":"2026-05-27T13:50:38.959189Z","steps":["trace[1543120567] 'read index received' (duration: 60.336596ms)","trace[1543120567] 'applied index is now lower than readState.Index' (duration: 370.291632ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:50:38.95926Z","caller":"traceutil/trace.go:171","msg":"trace[1006266234] transaction","detail":"{read_only:false; response_revision:2773; number_of_response:1; }","duration":"579.064464ms","start":"2026-05-27T13:50:38.380181Z","end":"2026-05-27T13:50:38.959246Z","steps":["trace[1006266234] 'process raft request' (duration: 208.736532ms)","trace[1006266234] 'compare' (duration: 369.925035ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:50:38.959332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:50:38.380152Z","time spent":"579.132915ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:50:38.959343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.78414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:50:38.959382Z","caller":"traceutil/trace.go:171","msg":"trace[1242416065] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2773; }","duration":"430.85389ms","start":"2026-05-27T13:50:38.528514Z","end":"2026-05-27T13:50:38.959367Z","steps":["trace[1242416065] 'agreement among raft nodes before linearized reading' (duration: 430.787209ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:50:38.959423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:50:38.528494Z","time spent":"430.919512ms","remote":"127.0.0.1:37092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-27T13:50:38.959552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.96585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18b3705c152acd18\" ","response":"range_response_count:1 size:781"} {"level":"info","ts":"2026-05-27T13:50:38.959577Z","caller":"traceutil/trace.go:171","msg":"trace[363687261] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18b3705c152acd18; range_end:; response_count:1; response_revision:2773; }","duration":"421.02234ms","start":"2026-05-27T13:50:38.538546Z","end":"2026-05-27T13:50:38.959568Z","steps":["trace[363687261] 'agreement among raft nodes before linearized reading' (duration: 420.909359ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:50:38.959599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:50:38.538526Z","time spent":"421.069241ms","remote":"127.0.0.1:37174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":805,"request content":"key:\"/registry/events/auth-system/keycloak-0.18b3705c152acd18\" "} {"level":"warn","ts":"2026-05-27T13:50:38.959736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.398904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-27T13:50:38.959756Z","caller":"traceutil/trace.go:171","msg":"trace[46135647] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2773; }","duration":"217.455294ms","start":"2026-05-27T13:50:38.742295Z","end":"2026-05-27T13:50:38.959751Z","steps":["trace[46135647] 'agreement among raft nodes before linearized reading' (duration: 217.396822ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:50:39.148417Z","caller":"traceutil/trace.go:171","msg":"trace[668872929] transaction","detail":"{read_only:false; response_revision:2778; number_of_response:1; }","duration":"182.478981ms","start":"2026-05-27T13:50:38.965914Z","end":"2026-05-27T13:50:39.148393Z","steps":["trace[668872929] 'process raft request' (duration: 182.353209ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:50:39.148374Z","caller":"traceutil/trace.go:171","msg":"trace[1196439116] transaction","detail":"{read_only:false; response_revision:2776; number_of_response:1; }","duration":"182.512082ms","start":"2026-05-27T13:50:38.965792Z","end":"2026-05-27T13:50:39.148304Z","steps":["trace[1196439116] 'process raft request' (duration: 182.326308ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:50:39.148372Z","caller":"traceutil/trace.go:171","msg":"trace[1805943408] transaction","detail":"{read_only:false; response_revision:2777; number_of_response:1; }","duration":"182.4889ms","start":"2026-05-27T13:50:38.965851Z","end":"2026-05-27T13:50:39.14834Z","steps":["trace[1805943408] 'process raft request' (duration: 182.353238ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:50:39.148309Z","caller":"traceutil/trace.go:171","msg":"trace[1615918021] transaction","detail":"{read_only:false; response_revision:2775; number_of_response:1; }","duration":"182.815245ms","start":"2026-05-27T13:50:38.965439Z","end":"2026-05-27T13:50:39.148254Z","steps":["trace[1615918021] 'process raft request' (duration: 178.641927ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:54:18.70123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.99148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-46cc9f9f-51a1-4d61-9624-6be27c9328e0\" ","response":"range_response_count:1 size:3774"} {"level":"info","ts":"2026-05-27T13:54:18.701755Z","caller":"traceutil/trace.go:171","msg":"trace[1045810097] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-46cc9f9f-51a1-4d61-9624-6be27c9328e0; range_end:; response_count:1; response_revision:4580; }","duration":"142.522934ms","start":"2026-05-27T13:54:18.559195Z","end":"2026-05-27T13:54:18.701718Z","steps":["trace[1045810097] 'range keys from in-memory index tree' (duration: 141.835907ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:54:20.77728Z","caller":"traceutil/trace.go:171","msg":"trace[937016087] transaction","detail":"{read_only:false; response_revision:4625; number_of_response:1; }","duration":"120.956665ms","start":"2026-05-27T13:54:20.656282Z","end":"2026-05-27T13:54:20.777239Z","steps":["trace[937016087] 'process raft request' (duration: 24.065268ms)","trace[937016087] 'compare' (duration: 96.791785ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:54:20.831791Z","caller":"traceutil/trace.go:171","msg":"trace[2135960582] linearizableReadLoop","detail":"{readStateIndex:4809; appliedIndex:4808; }","duration":"121.773955ms","start":"2026-05-27T13:54:20.710001Z","end":"2026-05-27T13:54:20.831775Z","steps":["trace[2135960582] 'read index received' (duration: 121.634562ms)","trace[2135960582] 'applied index is now lower than readState.Index' (duration: 138.713µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:54:20.832008Z","caller":"traceutil/trace.go:171","msg":"trace[2028730817] transaction","detail":"{read_only:false; response_revision:4626; number_of_response:1; }","duration":"165.80064ms","start":"2026-05-27T13:54:20.6662Z","end":"2026-05-27T13:54:20.832001Z","steps":["trace[2028730817] 'process raft request' (duration: 165.487252ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:54:20.832236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.224777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-46cc9f9f-51a1-4d61-9624-6be27c9328e0\" ","response":"range_response_count:1 size:4080"} {"level":"info","ts":"2026-05-27T13:54:20.832276Z","caller":"traceutil/trace.go:171","msg":"trace[1065470100] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-46cc9f9f-51a1-4d61-9624-6be27c9328e0; range_end:; response_count:1; response_revision:4626; }","duration":"122.310288ms","start":"2026-05-27T13:54:20.709957Z","end":"2026-05-27T13:54:20.832267Z","steps":["trace[1065470100] 'agreement among raft nodes before linearized reading' (duration: 122.192215ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:54:20.832382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.117809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:54:20.832416Z","caller":"traceutil/trace.go:171","msg":"trace[1606865321] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4626; }","duration":"117.182721ms","start":"2026-05-27T13:54:20.715228Z","end":"2026-05-27T13:54:20.832411Z","steps":["trace[1606865321] 'agreement among raft nodes before linearized reading' (duration: 117.136689ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:54:21.949677Z","caller":"traceutil/trace.go:171","msg":"trace[1830930528] transaction","detail":"{read_only:false; response_revision:4636; number_of_response:1; }","duration":"103.091926ms","start":"2026-05-27T13:54:21.846558Z","end":"2026-05-27T13:54:21.94965Z","steps":["trace[1830930528] 'process raft request' (duration: 99.859836ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:54:26.743708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.785037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-05-27T13:54:26.743748Z","caller":"traceutil/trace.go:171","msg":"trace[767072587] transaction","detail":"{read_only:false; response_revision:4746; number_of_response:1; }","duration":"284.218443ms","start":"2026-05-27T13:54:26.459501Z","end":"2026-05-27T13:54:26.743719Z","steps":["trace[767072587] 'process raft request' (duration: 198.451986ms)","trace[767072587] 'compare' (duration: 85.612564ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:54:26.743785Z","caller":"traceutil/trace.go:171","msg":"trace[152341523] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4745; }","duration":"284.88365ms","start":"2026-05-27T13:54:26.458879Z","end":"2026-05-27T13:54:26.743763Z","steps":["trace[152341523] 'range keys from in-memory index tree' (duration: 284.656883ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:54:26.750666Z","caller":"traceutil/trace.go:171","msg":"trace[776611093] linearizableReadLoop","detail":"{readStateIndex:4932; appliedIndex:4930; }","duration":"286.852818ms","start":"2026-05-27T13:54:26.463788Z","end":"2026-05-27T13:54:26.750641Z","steps":["trace[776611093] 'read index received' (duration: 193.980065ms)","trace[776611093] 'applied index is now lower than readState.Index' (duration: 92.871703ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:54:26.750923Z","caller":"traceutil/trace.go:171","msg":"trace[232007208] transaction","detail":"{read_only:false; response_revision:4747; number_of_response:1; }","duration":"287.226317ms","start":"2026-05-27T13:54:26.463684Z","end":"2026-05-27T13:54:26.750911Z","steps":["trace[232007208] 'process raft request' (duration: 286.814607ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:54:26.751253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.444232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:1453"} {"level":"info","ts":"2026-05-27T13:54:26.751295Z","caller":"traceutil/trace.go:171","msg":"trace[445006273] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4747; }","duration":"287.509904ms","start":"2026-05-27T13:54:26.463775Z","end":"2026-05-27T13:54:26.751285Z","steps":["trace[445006273] 'agreement among raft nodes before linearized reading' (duration: 287.322249ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:54:26.753376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.578146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9e403dd2-3560-4879-9e5a-9dfd4da32341\" ","response":"range_response_count:1 size:2580"} {"level":"info","ts":"2026-05-27T13:54:26.753479Z","caller":"traceutil/trace.go:171","msg":"trace[1948613478] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9e403dd2-3560-4879-9e5a-9dfd4da32341; range_end:; response_count:1; response_revision:4748; }","duration":"285.74039ms","start":"2026-05-27T13:54:26.467722Z","end":"2026-05-27T13:54:26.753463Z","steps":["trace[1948613478] 'agreement among raft nodes before linearized reading' (duration: 285.431072ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:54:26.753688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.200376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:54:26.753723Z","caller":"traceutil/trace.go:171","msg":"trace[1866921462] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4748; }","duration":"228.256908ms","start":"2026-05-27T13:54:26.525456Z","end":"2026-05-27T13:54:26.753713Z","steps":["trace[1866921462] 'agreement among raft nodes before linearized reading' (duration: 228.204367ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:54:26.754612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.546261ms","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-05-27T13:54:26.754647Z","caller":"traceutil/trace.go:171","msg":"trace[2000930345] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4748; }","duration":"107.618925ms","start":"2026-05-27T13:54:26.647018Z","end":"2026-05-27T13:54:26.754637Z","steps":["trace[2000930345] 'agreement among raft nodes before linearized reading' (duration: 106.797834ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:54:26.755584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.04496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9e403dd2-3560-4879-9e5a-9dfd4da32341\" ","response":"range_response_count:1 size:2580"} {"level":"info","ts":"2026-05-27T13:54:26.755684Z","caller":"traceutil/trace.go:171","msg":"trace[1993343386] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9e403dd2-3560-4879-9e5a-9dfd4da32341; range_end:; response_count:1; response_revision:4748; }","duration":"284.028888ms","start":"2026-05-27T13:54:26.471643Z","end":"2026-05-27T13:54:26.755672Z","steps":["trace[1993343386] 'agreement among raft nodes before linearized reading' (duration: 282.019519ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:54:27.706507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.260544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:54:27.706589Z","caller":"traceutil/trace.go:171","msg":"trace[335613321] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:4768; }","duration":"488.387787ms","start":"2026-05-27T13:54:27.21818Z","end":"2026-05-27T13:54:27.706568Z","steps":["trace[335613321] 'count revisions from in-memory index tree' (duration: 488.178612ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:54:27.706631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:54:27.218161Z","time spent":"488.458078ms","remote":"127.0.0.1:44874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-05-27T13:54:27.707269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.276994ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:54:27.707388Z","caller":"traceutil/trace.go:171","msg":"trace[707537939] transaction","detail":"{read_only:false; response_revision:4769; number_of_response:1; }","duration":"484.030479ms","start":"2026-05-27T13:54:27.223329Z","end":"2026-05-27T13:54:27.707359Z","steps":["trace[707537939] 'process raft request' (duration: 353.55929ms)","trace[707537939] 'compare' (duration: 129.25125ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:54:27.707381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.26735ms","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-05-27T13:54:27.707451Z","caller":"traceutil/trace.go:171","msg":"trace[1302005396] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4768; }","duration":"569.369322ms","start":"2026-05-27T13:54:27.138064Z","end":"2026-05-27T13:54:27.707434Z","steps":["trace[1302005396] 'range keys from in-memory index tree' (duration: 567.804884ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:54:27.707458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:54:27.223296Z","time spent":"484.131352ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:54:27.707513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:54:27.13804Z","time spent":"569.456095ms","remote":"127.0.0.1:37208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":47,"response size":2206997,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"warn","ts":"2026-05-27T13:54:28.112548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.001415ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:54:28.112832Z","caller":"traceutil/trace.go:171","msg":"trace[1493811819] linearizableReadLoop","detail":"{readStateIndex:4955; appliedIndex:4953; }","duration":"585.581395ms","start":"2026-05-27T13:54:27.52723Z","end":"2026-05-27T13:54:28.112811Z","steps":["trace[1493811819] 'read index received' (duration: 49.603186ms)","trace[1493811819] 'applied index is now lower than readState.Index' (duration: 535.976689ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:54:28.112908Z","caller":"traceutil/trace.go:171","msg":"trace[2042972153] transaction","detail":"{read_only:false; response_revision:4770; number_of_response:1; }","duration":"713.535124ms","start":"2026-05-27T13:54:27.399342Z","end":"2026-05-27T13:54:28.112877Z","steps":["trace[2042972153] 'process raft request' (duration: 534.142709ms)","trace[2042972153] 'compare' (duration: 178.874432ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:54:28.11298Z","caller":"traceutil/trace.go:171","msg":"trace[1249272653] transaction","detail":"{read_only:false; response_revision:4771; number_of_response:1; }","duration":"355.302719ms","start":"2026-05-27T13:54:27.75766Z","end":"2026-05-27T13:54:28.112962Z","steps":["trace[1249272653] 'process raft request' (duration: 354.984332ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:54:28.113054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:54:27.399317Z","time spent":"713.659847ms","remote":"127.0.0.1:37174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":814,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:54:28.113064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:54:27.75764Z","time spent":"355.37629ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:54:28.11309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.850322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:54:28.113149Z","caller":"traceutil/trace.go:171","msg":"trace[158786966] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4771; }","duration":"585.951075ms","start":"2026-05-27T13:54:27.527189Z","end":"2026-05-27T13:54:28.11314Z","steps":["trace[158786966] 'agreement among raft nodes before linearized reading' (duration: 585.820382ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:54:28.113174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:54:27.52717Z","time spent":"585.998786ms","remote":"127.0.0.1:37092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-27T13:54:28.113709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.343921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:54:28.113744Z","caller":"traceutil/trace.go:171","msg":"trace[1345210280] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:4774; }","duration":"404.419594ms","start":"2026-05-27T13:54:27.709315Z","end":"2026-05-27T13:54:28.113735Z","steps":["trace[1345210280] 'agreement among raft nodes before linearized reading' (duration: 404.342752ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:54:28.113737Z","caller":"traceutil/trace.go:171","msg":"trace[579206045] transaction","detail":"{read_only:false; response_revision:4772; number_of_response:1; }","duration":"122.371447ms","start":"2026-05-27T13:54:27.99135Z","end":"2026-05-27T13:54:28.113722Z","steps":["trace[579206045] 'process raft request' (duration: 121.376572ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:54:28.113787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:54:27.709298Z","time spent":"404.460465ms","remote":"127.0.0.1:44888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-05-27T13:54:28.113935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.169733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-27T13:54:28.113944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.119809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9e403dd2-3560-4879-9e5a-9dfd4da32341\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-05-27T13:54:28.113961Z","caller":"traceutil/trace.go:171","msg":"trace[1518586097] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4774; }","duration":"359.216946ms","start":"2026-05-27T13:54:27.754738Z","end":"2026-05-27T13:54:28.113955Z","steps":["trace[1518586097] 'agreement among raft nodes before linearized reading' (duration: 359.173364ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:54:28.114004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:54:27.754725Z","time spent":"359.250726ms","remote":"127.0.0.1:60568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"info","ts":"2026-05-27T13:54:28.114Z","caller":"traceutil/trace.go:171","msg":"trace[401181740] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9e403dd2-3560-4879-9e5a-9dfd4da32341; range_end:; response_count:1; response_revision:4774; }","duration":"356.191871ms","start":"2026-05-27T13:54:27.757773Z","end":"2026-05-27T13:54:28.113965Z","steps":["trace[401181740] 'agreement among raft nodes before linearized reading' (duration: 356.075688ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:54:28.114222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.169919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12975"} {"level":"info","ts":"2026-05-27T13:54:28.114305Z","caller":"traceutil/trace.go:171","msg":"trace[235822358] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4774; }","duration":"389.292882ms","start":"2026-05-27T13:54:27.724991Z","end":"2026-05-27T13:54:28.114284Z","steps":["trace[235822358] 'agreement among raft nodes before linearized reading' (duration: 389.085107ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:54:28.114366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:54:27.724971Z","time spent":"389.384814ms","remote":"127.0.0.1:37272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":1,"response size":12999,"request content":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"warn","ts":"2026-05-27T13:54:28.114625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.239827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-05-27T13:54:28.114669Z","caller":"traceutil/trace.go:171","msg":"trace[1267255097] 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:4774; }","duration":"366.309798ms","start":"2026-05-27T13:54:27.748345Z","end":"2026-05-27T13:54:28.114655Z","steps":["trace[1267255097] 'agreement among raft nodes before linearized reading' (duration: 366.195135ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:54:28.114703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:54:27.748329Z","time spent":"366.36418ms","remote":"127.0.0.1:37248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2106,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"warn","ts":"2026-05-27T13:54:28.114237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:54:27.757717Z","time spent":"356.506428ms","remote":"127.0.0.1:37272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3670,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9e403dd2-3560-4879-9e5a-9dfd4da32341\" "} {"level":"warn","ts":"2026-05-27T13:54:28.114976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.435972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-05-27T13:54:28.115004Z","caller":"traceutil/trace.go:171","msg":"trace[1789486747] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4774; }","duration":"377.503412ms","start":"2026-05-27T13:54:27.737493Z","end":"2026-05-27T13:54:28.114996Z","steps":["trace[1789486747] 'agreement among raft nodes before linearized reading' (duration: 377.39799ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:54:28.115044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:54:27.737475Z","time spent":"377.560915ms","remote":"127.0.0.1:37192","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":1841,"request content":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" "} {"level":"warn","ts":"2026-05-27T13:54:28.699255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.733338ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:54:28.699449Z","caller":"traceutil/trace.go:171","msg":"trace[1203249147] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:4784; }","duration":"210.938533ms","start":"2026-05-27T13:54:28.488492Z","end":"2026-05-27T13:54:28.699431Z","steps":["trace[1203249147] 'range keys from in-memory index tree' (duration: 210.716868ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:54:28.699434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.970232ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:54:28.699756Z","caller":"traceutil/trace.go:171","msg":"trace[1650696793] transaction","detail":"{read_only:false; response_revision:4785; number_of_response:1; }","duration":"364.517024ms","start":"2026-05-27T13:54:28.335208Z","end":"2026-05-27T13:54:28.699725Z","steps":["trace[1650696793] 'process raft request' (duration: 178.124761ms)","trace[1650696793] 'compare' (duration: 185.813719ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:54:28.699882Z","caller":"traceutil/trace.go:171","msg":"trace[1991217799] linearizableReadLoop","detail":"{readStateIndex:4974; appliedIndex:4970; }","duration":"359.08069ms","start":"2026-05-27T13:54:28.340781Z","end":"2026-05-27T13:54:28.699862Z","steps":["trace[1991217799] 'read index received' (duration: 172.566054ms)","trace[1991217799] 'applied index is now lower than readState.Index' (duration: 186.513296ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:54:28.699901Z","caller":"traceutil/trace.go:171","msg":"trace[120116101] transaction","detail":"{read_only:false; response_revision:4787; number_of_response:1; }","duration":"361.404657ms","start":"2026-05-27T13:54:28.338467Z","end":"2026-05-27T13:54:28.699872Z","steps":["trace[120116101] 'process raft request' (duration: 361.238744ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:54:28.699981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:54:28.335177Z","time spent":"364.713797ms","remote":"127.0.0.1:37352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1392,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:54:28.700061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:54:28.338445Z","time spent":"361.532831ms","remote":"127.0.0.1:37254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1272,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:54:28.700076Z","caller":"traceutil/trace.go:171","msg":"trace[942384037] transaction","detail":"{read_only:false; response_revision:4786; number_of_response:1; }","duration":"363.672423ms","start":"2026-05-27T13:54:28.336386Z","end":"2026-05-27T13:54:28.700059Z","steps":["trace[942384037] 'process raft request' (duration: 363.197402ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:54:28.700141Z","caller":"traceutil/trace.go:171","msg":"trace[449199784] transaction","detail":"{read_only:false; response_revision:4788; number_of_response:1; }","duration":"361.599942ms","start":"2026-05-27T13:54:28.338501Z","end":"2026-05-27T13:54:28.700101Z","steps":["trace[449199784] 'process raft request' (duration: 361.311445ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:54:28.700173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:54:28.336374Z","time spent":"363.738495ms","remote":"127.0.0.1:37254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:54:28.70021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.914699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:993"} {"level":"info","ts":"2026-05-27T13:54:28.70025Z","caller":"traceutil/trace.go:171","msg":"trace[136635119] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:4788; }","duration":"361.972291ms","start":"2026-05-27T13:54:28.338267Z","end":"2026-05-27T13:54:28.70024Z","steps":["trace[136635119] 'agreement among raft nodes before linearized reading' (duration: 361.838137ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:54:28.700287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:54:28.338254Z","time spent":"362.025763ms","remote":"127.0.0.1:37286","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":1017,"request content":"key:\"/registry/services/specs/monitoring/prometheus-operated\" "} {"level":"warn","ts":"2026-05-27T13:54:28.700245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:54:28.338445Z","time spent":"361.733916ms","remote":"127.0.0.1:37352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1852,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:54:28.960728Z","caller":"traceutil/trace.go:171","msg":"trace[899488636] linearizableReadLoop","detail":"{readStateIndex:4975; appliedIndex:4974; }","duration":"260.736793ms","start":"2026-05-27T13:54:28.699954Z","end":"2026-05-27T13:54:28.960691Z","steps":["trace[899488636] 'read index received' (duration: 200.014826ms)","trace[899488636] 'applied index is now lower than readState.Index' (duration: 60.720677ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:54:28.961271Z","caller":"traceutil/trace.go:171","msg":"trace[646689387] transaction","detail":"{read_only:false; response_revision:4789; number_of_response:1; }","duration":"617.079387ms","start":"2026-05-27T13:54:28.344169Z","end":"2026-05-27T13:54:28.961249Z","steps":["trace[646689387] 'process raft request' (duration: 555.766486ms)","trace[646689387] 'compare' (duration: 59.939388ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:54:28.961449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:54:28.344162Z","time spent":"617.162399ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:54:28.9615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.896042ms","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-05-27T13:54:28.961549Z","caller":"traceutil/trace.go:171","msg":"trace[2082514671] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:4789; }","duration":"357.988114ms","start":"2026-05-27T13:54:28.603546Z","end":"2026-05-27T13:54:28.961534Z","steps":["trace[2082514671] 'agreement among raft nodes before linearized reading' (duration: 357.833051ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:54:28.961583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:54:28.603525Z","time spent":"358.050085ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":554,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"warn","ts":"2026-05-27T13:54:28.961602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.5006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-27T13:54:28.961698Z","caller":"traceutil/trace.go:171","msg":"trace[1588728975] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4789; }","duration":"582.691454ms","start":"2026-05-27T13:54:28.378981Z","end":"2026-05-27T13:54:28.961673Z","steps":["trace[1588728975] 'agreement among raft nodes before linearized reading' (duration: 582.373156ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:54:28.961725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.793151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-27T13:54:28.961752Z","caller":"traceutil/trace.go:171","msg":"trace[1006367242] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4789; }","duration":"565.844792ms","start":"2026-05-27T13:54:28.395899Z","end":"2026-05-27T13:54:28.961743Z","steps":["trace[1006367242] 'agreement among raft nodes before linearized reading' (duration: 565.75111ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:54:28.961752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:54:28.378961Z","time spent":"582.778987ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-27T13:54:28.961777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:54:28.395885Z","time spent":"565.887343ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-27T13:54:28.961896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.728411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:61714"} {"level":"info","ts":"2026-05-27T13:54:28.961944Z","caller":"traceutil/trace.go:171","msg":"trace[1571383007] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4789; }","duration":"253.793153ms","start":"2026-05-27T13:54:28.708137Z","end":"2026-05-27T13:54:28.96193Z","steps":["trace[1571383007] 'agreement among raft nodes before linearized reading' (duration: 253.573878ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:54:28.962196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.245292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-05-27T13:54:28.962226Z","caller":"traceutil/trace.go:171","msg":"trace[1305786283] 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:4789; }","duration":"200.321613ms","start":"2026-05-27T13:54:28.761894Z","end":"2026-05-27T13:54:28.962216Z","steps":["trace[1305786283] 'agreement among raft nodes before linearized reading' (duration: 200.239712ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:54:29.188886Z","caller":"traceutil/trace.go:171","msg":"trace[182867741] transaction","detail":"{read_only:false; response_revision:4793; number_of_response:1; }","duration":"211.607182ms","start":"2026-05-27T13:54:28.977258Z","end":"2026-05-27T13:54:29.188865Z","steps":["trace[182867741] 'process raft request' (duration: 211.51487ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:54:29.188878Z","caller":"traceutil/trace.go:171","msg":"trace[1081203792] linearizableReadLoop","detail":"{readStateIndex:4979; appliedIndex:4976; }","duration":"179.551558ms","start":"2026-05-27T13:54:29.009301Z","end":"2026-05-27T13:54:29.188852Z","steps":["trace[1081203792] 'read index received' (duration: 147.965065ms)","trace[1081203792] 'applied index is now lower than readState.Index' (duration: 31.585173ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:54:29.188973Z","caller":"traceutil/trace.go:171","msg":"trace[1840949434] transaction","detail":"{read_only:false; response_revision:4791; number_of_response:1; }","duration":"221.519315ms","start":"2026-05-27T13:54:28.967378Z","end":"2026-05-27T13:54:29.188897Z","steps":["trace[1840949434] 'process raft request' (duration: 189.952653ms)","trace[1840949434] 'compare' (duration: 30.875415ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:54:29.189063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.738122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-05-27T13:54:29.189136Z","caller":"traceutil/trace.go:171","msg":"trace[1226058779] 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:4793; }","duration":"179.842245ms","start":"2026-05-27T13:54:29.009274Z","end":"2026-05-27T13:54:29.189116Z","steps":["trace[1226058779] 'agreement among raft nodes before linearized reading' (duration: 179.65462ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:54:29.189286Z","caller":"traceutil/trace.go:171","msg":"trace[1808721984] transaction","detail":"{read_only:false; response_revision:4792; number_of_response:1; }","duration":"219.439144ms","start":"2026-05-27T13:54:28.969826Z","end":"2026-05-27T13:54:29.189265Z","steps":["trace[1808721984] 'process raft request' (duration: 218.87247ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:55:01.556087Z","caller":"traceutil/trace.go:171","msg":"trace[1605582900] linearizableReadLoop","detail":"{readStateIndex:5243; appliedIndex:5242; }","duration":"456.671393ms","start":"2026-05-27T13:55:01.099392Z","end":"2026-05-27T13:55:01.556064Z","steps":["trace[1605582900] 'read index received' (duration: 456.51095ms)","trace[1605582900] 'applied index is now lower than readState.Index' (duration: 159.243µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:55:01.556181Z","caller":"traceutil/trace.go:171","msg":"trace[860752289] transaction","detail":"{read_only:false; response_revision:5048; number_of_response:1; }","duration":"602.105698ms","start":"2026-05-27T13:55:00.954057Z","end":"2026-05-27T13:55:01.556162Z","steps":["trace[860752289] 'process raft request' (duration: 601.859922ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:55:01.556396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.989771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-05-27T13:55:01.556404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:55:00.954044Z","time spent":"602.256054ms","remote":"127.0.0.1:37272","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10670,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:55:01.55649Z","caller":"traceutil/trace.go:171","msg":"trace[773140855] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5048; }","duration":"457.106374ms","start":"2026-05-27T13:55:01.099349Z","end":"2026-05-27T13:55:01.556455Z","steps":["trace[773140855] 'agreement among raft nodes before linearized reading' (duration: 456.844778ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:55:01.55653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:55:01.099319Z","time spent":"457.203397ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-27T13:55:01.569014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.364948ms","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-05-27T13:55:01.569071Z","caller":"traceutil/trace.go:171","msg":"trace[826314223] transaction","detail":"{read_only:false; response_revision:5049; number_of_response:1; }","duration":"379.987045ms","start":"2026-05-27T13:55:01.189073Z","end":"2026-05-27T13:55:01.56906Z","steps":["trace[826314223] 'process raft request' (duration: 379.74848ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:55:01.569084Z","caller":"traceutil/trace.go:171","msg":"trace[222288250] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:5049; }","duration":"444.481692ms","start":"2026-05-27T13:55:01.124588Z","end":"2026-05-27T13:55:01.569069Z","steps":["trace[222288250] 'agreement among raft nodes before linearized reading' (duration: 444.344069ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:55:01.569135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:55:01.189052Z","time spent":"380.040886ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:55:01.569161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:55:01.124573Z","time spent":"444.578264ms","remote":"127.0.0.1:54514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-27T13:55:01.569023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.558289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T13:55:01.569401Z","caller":"traceutil/trace.go:171","msg":"trace[1742266642] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:5049; }","duration":"189.949177ms","start":"2026-05-27T13:55:01.379416Z","end":"2026-05-27T13:55:01.569365Z","steps":["trace[1742266642] 'agreement among raft nodes before linearized reading' (duration: 189.527397ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:55:01.569453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.027044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-27T13:55:01.569478Z","caller":"traceutil/trace.go:171","msg":"trace[419188603] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5049; }","duration":"426.100905ms","start":"2026-05-27T13:55:01.143369Z","end":"2026-05-27T13:55:01.56947Z","steps":["trace[419188603] 'agreement among raft nodes before linearized reading' (duration: 425.992583ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:55:01.569503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:55:01.143333Z","time spent":"426.161656ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-27T13:55:01.569789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.977516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-27T13:55:01.569826Z","caller":"traceutil/trace.go:171","msg":"trace[1182887853] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5049; }","duration":"218.070299ms","start":"2026-05-27T13:55:01.351746Z","end":"2026-05-27T13:55:01.569817Z","steps":["trace[1182887853] 'agreement among raft nodes before linearized reading' (duration: 217.954816ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:55:01.569896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.05095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-05-27T13:55:01.569984Z","caller":"traceutil/trace.go:171","msg":"trace[672409246] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5049; }","duration":"315.144382ms","start":"2026-05-27T13:55:01.254822Z","end":"2026-05-27T13:55:01.569966Z","steps":["trace[672409246] 'agreement among raft nodes before linearized reading' (duration: 314.924767ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:55:01.570026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:55:01.254793Z","time spent":"315.224133ms","remote":"127.0.0.1:60388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3340,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"info","ts":"2026-05-27T13:55:02.477305Z","caller":"traceutil/trace.go:171","msg":"trace[1222011674] transaction","detail":"{read_only:false; response_revision:5063; number_of_response:1; }","duration":"102.828121ms","start":"2026-05-27T13:55:02.374456Z","end":"2026-05-27T13:55:02.477284Z","steps":["trace[1222011674] 'process raft request' (duration: 77.231449ms)","trace[1222011674] 'compare' (duration: 25.401578ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:56:01.778841Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2901} {"level":"info","ts":"2026-05-27T13:56:01.966982Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2901,"took":"186.685198ms","hash":2112863516,"current-db-size-bytes":51916800,"current-db-size":"52 MB","current-db-size-in-use-bytes":28409856,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-05-27T13:56:01.967079Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2112863516,"revision":2901,"compact-revision":-1} {"level":"warn","ts":"2026-05-27T13:56:25.369528Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8934752887500592620,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-27T13:56:25.72744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.35864ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"info","ts":"2026-05-27T13:56:25.72767Z","caller":"traceutil/trace.go:171","msg":"trace[2140481678] linearizableReadLoop","detail":"{readStateIndex:5920; appliedIndex:5919; }","duration":"859.078954ms","start":"2026-05-27T13:56:24.868571Z","end":"2026-05-27T13:56:25.72765Z","steps":["trace[2140481678] 'read index received' (duration: 503.425597ms)","trace[2140481678] 'applied index is now lower than readState.Index' (duration: 355.651797ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:56:25.727667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:56:24.826913Z","time spent":"900.746685ms","remote":"127.0.0.1:37130","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-27T13:56:25.727871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.849998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:56:25.727947Z","caller":"traceutil/trace.go:171","msg":"trace[812696664] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5705; }","duration":"199.974871ms","start":"2026-05-27T13:56:25.527949Z","end":"2026-05-27T13:56:25.727924Z","steps":["trace[812696664] 'agreement among raft nodes before linearized reading' (duration: 199.843359ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:56:25.728003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"859.427822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-27T13:56:25.72814Z","caller":"traceutil/trace.go:171","msg":"trace[1397162893] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5705; }","duration":"859.593886ms","start":"2026-05-27T13:56:24.868534Z","end":"2026-05-27T13:56:25.728128Z","steps":["trace[1397162893] 'agreement among raft nodes before linearized reading' (duration: 859.206158ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:56:25.728264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:56:24.868519Z","time spent":"859.731948ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-27T13:57:26.943169Z","caller":"traceutil/trace.go:171","msg":"trace[1799816458] transaction","detail":"{read_only:false; response_revision:6069; number_of_response:1; }","duration":"108.14254ms","start":"2026-05-27T13:57:26.834717Z","end":"2026-05-27T13:57:26.94286Z","steps":["trace[1799816458] 'process raft request' (duration: 53.015633ms)","trace[1799816458] 'compare' (duration: 54.995424ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:57:41.177036Z","caller":"traceutil/trace.go:171","msg":"trace[1252465006] transaction","detail":"{read_only:false; response_revision:6138; number_of_response:1; }","duration":"217.529593ms","start":"2026-05-27T13:57:40.959483Z","end":"2026-05-27T13:57:41.177013Z","steps":["trace[1252465006] 'process raft request' (duration: 217.397481ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:57:41.229619Z","caller":"traceutil/trace.go:171","msg":"trace[101095998] transaction","detail":"{read_only:false; response_revision:6139; number_of_response:1; }","duration":"242.674178ms","start":"2026-05-27T13:57:40.986917Z","end":"2026-05-27T13:57:41.229591Z","steps":["trace[101095998] 'process raft request' (duration: 242.492104ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:57:41.229983Z","caller":"traceutil/trace.go:171","msg":"trace[721508722] linearizableReadLoop","detail":"{readStateIndex:6370; appliedIndex:6368; }","duration":"129.161946ms","start":"2026-05-27T13:57:41.100598Z","end":"2026-05-27T13:57:41.22976Z","steps":["trace[721508722] 'read index received' (duration: 76.338464ms)","trace[721508722] 'applied index is now lower than readState.Index' (duration: 52.821202ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:57:41.230122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.443732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:57:41.230313Z","caller":"traceutil/trace.go:171","msg":"trace[524211238] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:6140; }","duration":"129.695818ms","start":"2026-05-27T13:57:41.100552Z","end":"2026-05-27T13:57:41.230248Z","steps":["trace[524211238] 'agreement among raft nodes before linearized reading' (duration: 129.380021ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:57:42.392196Z","caller":"traceutil/trace.go:171","msg":"trace[139963324] transaction","detail":"{read_only:false; response_revision:6144; number_of_response:1; }","duration":"151.064575ms","start":"2026-05-27T13:57:42.241106Z","end":"2026-05-27T13:57:42.39217Z","steps":["trace[139963324] 'process raft request' (duration: 150.923202ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:57:47.308733Z","caller":"traceutil/trace.go:171","msg":"trace[225533126] transaction","detail":"{read_only:false; response_revision:6180; number_of_response:1; }","duration":"113.486205ms","start":"2026-05-27T13:57:47.195041Z","end":"2026-05-27T13:57:47.308527Z","steps":["trace[225533126] 'process raft request' (duration: 113.321901ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:57:47.442738Z","caller":"traceutil/trace.go:171","msg":"trace[476474701] transaction","detail":"{read_only:false; response_revision:6181; number_of_response:1; }","duration":"195.879446ms","start":"2026-05-27T13:57:47.246828Z","end":"2026-05-27T13:57:47.442707Z","steps":["trace[476474701] 'process raft request' (duration: 195.680672ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:57:47.442812Z","caller":"traceutil/trace.go:171","msg":"trace[1703948759] linearizableReadLoop","detail":"{readStateIndex:6415; appliedIndex:6413; }","duration":"129.627398ms","start":"2026-05-27T13:57:47.313166Z","end":"2026-05-27T13:57:47.442793Z","steps":["trace[1703948759] 'read index received' (duration: 129.27309ms)","trace[1703948759] 'applied index is now lower than readState.Index' (duration: 352.998µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:57:47.442884Z","caller":"traceutil/trace.go:171","msg":"trace[2073501487] transaction","detail":"{read_only:false; response_revision:6182; number_of_response:1; }","duration":"195.004289ms","start":"2026-05-27T13:57:47.24785Z","end":"2026-05-27T13:57:47.442854Z","steps":["trace[2073501487] 'process raft request' (duration: 194.808445ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:57:47.442977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.787651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T13:57:47.443011Z","caller":"traceutil/trace.go:171","msg":"trace[1888675677] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:6182; }","duration":"129.863213ms","start":"2026-05-27T13:57:47.313138Z","end":"2026-05-27T13:57:47.443002Z","steps":["trace[1888675677] 'agreement among raft nodes before linearized reading' (duration: 129.739029ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:57:48.848731Z","caller":"traceutil/trace.go:171","msg":"trace[1124420513] transaction","detail":"{read_only:false; response_revision:6187; number_of_response:1; }","duration":"107.981712ms","start":"2026-05-27T13:57:48.740728Z","end":"2026-05-27T13:57:48.848709Z","steps":["trace[1124420513] 'process raft request' (duration: 107.86262ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:57:48.849598Z","caller":"traceutil/trace.go:171","msg":"trace[467673858] transaction","detail":"{read_only:false; response_revision:6188; number_of_response:1; }","duration":"107.762109ms","start":"2026-05-27T13:57:48.741822Z","end":"2026-05-27T13:57:48.849584Z","steps":["trace[467673858] 'process raft request' (duration: 107.696338ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:58:09.533198Z","caller":"traceutil/trace.go:171","msg":"trace[1477853944] linearizableReadLoop","detail":"{readStateIndex:6553; appliedIndex:6552; }","duration":"148.414177ms","start":"2026-05-27T13:58:09.38476Z","end":"2026-05-27T13:58:09.533174Z","steps":["trace[1477853944] 'read index received' (duration: 120.439912ms)","trace[1477853944] 'applied index is now lower than readState.Index' (duration: 27.972445ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:58:09.533363Z","caller":"traceutil/trace.go:171","msg":"trace[961618053] transaction","detail":"{read_only:false; response_revision:6316; number_of_response:1; }","duration":"156.448766ms","start":"2026-05-27T13:58:09.376851Z","end":"2026-05-27T13:58:09.5333Z","steps":["trace[961618053] 'process raft request' (duration: 128.431749ms)","trace[961618053] 'compare' (duration: 27.425615ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:58:09.533698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.918587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-27T13:58:09.533802Z","caller":"traceutil/trace.go:171","msg":"trace[1141749263] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:6316; }","duration":"149.120432ms","start":"2026-05-27T13:58:09.384659Z","end":"2026-05-27T13:58:09.53378Z","steps":["trace[1141749263] 'agreement among raft nodes before linearized reading' (duration: 148.600051ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:58:09.724806Z","caller":"traceutil/trace.go:171","msg":"trace[2123010137] transaction","detail":"{read_only:false; response_revision:6318; number_of_response:1; }","duration":"205.203014ms","start":"2026-05-27T13:58:09.51957Z","end":"2026-05-27T13:58:09.724773Z","steps":["trace[2123010137] 'process raft request' (duration: 153.819474ms)","trace[2123010137] 'compare' (duration: 51.158966ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:58:09.725347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.797607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:58:09.725409Z","caller":"traceutil/trace.go:171","msg":"trace[1074521883] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6318; }","duration":"198.880719ms","start":"2026-05-27T13:58:09.52651Z","end":"2026-05-27T13:58:09.725391Z","steps":["trace[1074521883] 'agreement among raft nodes before linearized reading' (duration: 198.781677ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:58:09.725478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.716006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:58:09.725574Z","caller":"traceutil/trace.go:171","msg":"trace[567326717] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:6318; }","duration":"199.851728ms","start":"2026-05-27T13:58:09.525702Z","end":"2026-05-27T13:58:09.725554Z","steps":["trace[567326717] 'agreement among raft nodes before linearized reading' (duration: 199.681954ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:58:09.725717Z","caller":"traceutil/trace.go:171","msg":"trace[352319663] linearizableReadLoop","detail":"{readStateIndex:6555; appliedIndex:6553; }","duration":"191.38427ms","start":"2026-05-27T13:58:09.533354Z","end":"2026-05-27T13:58:09.724738Z","steps":["trace[352319663] 'read index received' (duration: 77.287705ms)","trace[352319663] 'applied index is now lower than readState.Index' (duration: 114.095075ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:58:09.899725Z","caller":"traceutil/trace.go:171","msg":"trace[1557790626] transaction","detail":"{read_only:false; response_revision:6320; number_of_response:1; }","duration":"138.621672ms","start":"2026-05-27T13:58:09.761071Z","end":"2026-05-27T13:58:09.899692Z","steps":["trace[1557790626] 'process raft request' (duration: 112.213917ms)","trace[1557790626] 'compare' (duration: 26.155869ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:58:09.994578Z","caller":"traceutil/trace.go:171","msg":"trace[893891735] transaction","detail":"{read_only:false; response_revision:6321; number_of_response:1; }","duration":"123.996022ms","start":"2026-05-27T13:58:09.870526Z","end":"2026-05-27T13:58:09.994522Z","steps":["trace[893891735] 'process raft request' (duration: 123.728887ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:58:09.994711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.25731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T13:58:09.994798Z","caller":"traceutil/trace.go:171","msg":"trace[874904137] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:6322; }","duration":"176.390022ms","start":"2026-05-27T13:58:09.818383Z","end":"2026-05-27T13:58:09.994773Z","steps":["trace[874904137] 'agreement among raft nodes before linearized reading' (duration: 176.188948ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:58:31.309668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.263544ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:58:31.310207Z","caller":"traceutil/trace.go:171","msg":"trace[594084082] transaction","detail":"{read_only:false; response_revision:6469; number_of_response:1; }","duration":"118.748069ms","start":"2026-05-27T13:58:31.191442Z","end":"2026-05-27T13:58:31.31019Z","steps":["trace[594084082] 'process raft request' (duration: 13.887454ms)","trace[594084082] 'compare' (duration: 104.09011ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:58:51.322528Z","caller":"traceutil/trace.go:171","msg":"trace[104745137] transaction","detail":"{read_only:false; response_revision:6692; number_of_response:1; }","duration":"105.276912ms","start":"2026-05-27T13:58:51.217223Z","end":"2026-05-27T13:58:51.3225Z","steps":["trace[104745137] 'process raft request' (duration: 105.136989ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:58:52.085158Z","caller":"traceutil/trace.go:171","msg":"trace[465847484] transaction","detail":"{read_only:false; response_revision:6696; number_of_response:1; }","duration":"169.477527ms","start":"2026-05-27T13:58:51.915633Z","end":"2026-05-27T13:58:52.08511Z","steps":["trace[465847484] 'process raft request' (duration: 94.098651ms)","trace[465847484] 'compare' (duration: 75.279474ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:58:52.981758Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8934752887500595075,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-27T13:58:53.102878Z","caller":"traceutil/trace.go:171","msg":"trace[559343662] transaction","detail":"{read_only:false; response_revision:6697; number_of_response:1; }","duration":"998.500641ms","start":"2026-05-27T13:58:52.104357Z","end":"2026-05-27T13:58:53.102857Z","steps":["trace[559343662] 'process raft request' (duration: 998.408209ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:58:53.103092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:58:52.104331Z","time spent":"998.603853ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:58:53.111311Z","caller":"traceutil/trace.go:171","msg":"trace[920905043] linearizableReadLoop","detail":"{readStateIndex:6948; appliedIndex:6947; }","duration":"630.309616ms","start":"2026-05-27T13:58:52.48098Z","end":"2026-05-27T13:58:53.111289Z","steps":["trace[920905043] 'read index received' (duration: 621.960162ms)","trace[920905043] 'applied index is now lower than readState.Index' (duration: 8.348054ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:58:53.111428Z","caller":"traceutil/trace.go:171","msg":"trace[1862729826] transaction","detail":"{read_only:false; response_revision:6698; number_of_response:1; }","duration":"179.777797ms","start":"2026-05-27T13:58:52.931632Z","end":"2026-05-27T13:58:53.11141Z","steps":["trace[1862729826] 'process raft request' (duration: 179.529292ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:58:53.111586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.361137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:58:53.11169Z","caller":"traceutil/trace.go:171","msg":"trace[1266451676] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6698; }","duration":"584.450738ms","start":"2026-05-27T13:58:52.52718Z","end":"2026-05-27T13:58:53.111631Z","steps":["trace[1266451676] 'agreement among raft nodes before linearized reading' (duration: 584.359176ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:58:53.111727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:58:52.527166Z","time spent":"584.55275ms","remote":"127.0.0.1:37092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-27T13:58:53.111893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.919787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T13:58:53.111917Z","caller":"traceutil/trace.go:171","msg":"trace[1921055656] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:6698; }","duration":"630.945048ms","start":"2026-05-27T13:58:52.480965Z","end":"2026-05-27T13:58:53.11191Z","steps":["trace[1921055656] 'agreement among raft nodes before linearized reading' (duration: 630.904747ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:58:53.111936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:58:52.480913Z","time spent":"631.017828ms","remote":"127.0.0.1:43400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":31,"request content":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true "} {"level":"warn","ts":"2026-05-27T13:58:53.112218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.389399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-27T13:58:53.112242Z","caller":"traceutil/trace.go:171","msg":"trace[1585951830] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6698; }","duration":"136.456329ms","start":"2026-05-27T13:58:52.975779Z","end":"2026-05-27T13:58:53.112236Z","steps":["trace[1585951830] 'agreement among raft nodes before linearized reading' (duration: 136.370548ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:58:53.112384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.214313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-27T13:58:53.112439Z","caller":"traceutil/trace.go:171","msg":"trace[627841444] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6698; }","duration":"166.310823ms","start":"2026-05-27T13:58:52.946113Z","end":"2026-05-27T13:58:53.112424Z","steps":["trace[627841444] 'agreement among raft nodes before linearized reading' (duration: 166.137381ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:58:55.945594Z","caller":"traceutil/trace.go:171","msg":"trace[667792115] transaction","detail":"{read_only:false; response_revision:6720; number_of_response:1; }","duration":"179.50549ms","start":"2026-05-27T13:58:55.765819Z","end":"2026-05-27T13:58:55.945325Z","steps":["trace[667792115] 'process raft request' (duration: 179.360636ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:58:55.97604Z","caller":"traceutil/trace.go:171","msg":"trace[327494625] transaction","detail":"{read_only:false; response_revision:6721; number_of_response:1; }","duration":"170.711839ms","start":"2026-05-27T13:58:55.80531Z","end":"2026-05-27T13:58:55.976022Z","steps":["trace[327494625] 'process raft request' (duration: 170.624287ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:59:08.841013Z","caller":"traceutil/trace.go:171","msg":"trace[1501354503] transaction","detail":"{read_only:false; response_revision:6832; number_of_response:1; }","duration":"158.477178ms","start":"2026-05-27T13:59:08.682515Z","end":"2026-05-27T13:59:08.840992Z","steps":["trace[1501354503] 'process raft request' (duration: 158.365266ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:59:08.861481Z","caller":"traceutil/trace.go:171","msg":"trace[1805958574] linearizableReadLoop","detail":"{readStateIndex:7089; appliedIndex:7088; }","duration":"122.19182ms","start":"2026-05-27T13:59:08.739257Z","end":"2026-05-27T13:59:08.861449Z","steps":["trace[1805958574] 'read index received' (duration: 102.242032ms)","trace[1805958574] 'applied index is now lower than readState.Index' (duration: 19.948368ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:59:08.861626Z","caller":"traceutil/trace.go:171","msg":"trace[1916920660] transaction","detail":"{read_only:false; response_revision:6833; number_of_response:1; }","duration":"178.962877ms","start":"2026-05-27T13:59:08.682649Z","end":"2026-05-27T13:59:08.861612Z","steps":["trace[1916920660] 'process raft request' (duration: 178.657911ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:59:08.861959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.673991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T13:59:08.862025Z","caller":"traceutil/trace.go:171","msg":"trace[823517340] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:6833; }","duration":"122.785522ms","start":"2026-05-27T13:59:08.739221Z","end":"2026-05-27T13:59:08.862007Z","steps":["trace[823517340] 'agreement among raft nodes before linearized reading' (duration: 122.64227ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:59:09.052473Z","caller":"traceutil/trace.go:171","msg":"trace[1059151284] transaction","detail":"{read_only:false; response_revision:6834; number_of_response:1; }","duration":"179.387996ms","start":"2026-05-27T13:59:08.873062Z","end":"2026-05-27T13:59:09.05245Z","steps":["trace[1059151284] 'process raft request' (duration: 169.789769ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:59:09.225667Z","caller":"traceutil/trace.go:171","msg":"trace[411054027] linearizableReadLoop","detail":"{readStateIndex:7091; appliedIndex:7090; }","duration":"111.400211ms","start":"2026-05-27T13:59:09.114237Z","end":"2026-05-27T13:59:09.225638Z","steps":["trace[411054027] 'read index received' (duration: 108.78ms)","trace[411054027] 'applied index is now lower than readState.Index' (duration: 2.619211ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:59:09.225933Z","caller":"traceutil/trace.go:171","msg":"trace[545721988] transaction","detail":"{read_only:false; response_revision:6835; number_of_response:1; }","duration":"158.844784ms","start":"2026-05-27T13:59:09.067073Z","end":"2026-05-27T13:59:09.225918Z","steps":["trace[545721988] 'process raft request' (duration: 156.036939ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:59:09.226173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.907911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T13:59:09.226213Z","caller":"traceutil/trace.go:171","msg":"trace[2022003916] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:6835; }","duration":"112.004242ms","start":"2026-05-27T13:59:09.114199Z","end":"2026-05-27T13:59:09.226203Z","steps":["trace[2022003916] 'agreement among raft nodes before linearized reading' (duration: 111.91565ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:59:11.546631Z","caller":"traceutil/trace.go:171","msg":"trace[2004950474] transaction","detail":"{read_only:false; response_revision:6854; number_of_response:1; }","duration":"123.557846ms","start":"2026-05-27T13:59:11.423039Z","end":"2026-05-27T13:59:11.546597Z","steps":["trace[2004950474] 'process raft request' (duration: 102.395824ms)","trace[2004950474] 'compare' (duration: 21.04269ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:59:18.479094Z","caller":"traceutil/trace.go:171","msg":"trace[1231333325] transaction","detail":"{read_only:false; response_revision:6891; number_of_response:1; }","duration":"165.265682ms","start":"2026-05-27T13:59:18.313791Z","end":"2026-05-27T13:59:18.479057Z","steps":["trace[1231333325] 'process raft request' (duration: 165.031967ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:59:19.445653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.281621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:59:19.445757Z","caller":"traceutil/trace.go:171","msg":"trace[1906170566] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:6891; }","duration":"274.425193ms","start":"2026-05-27T13:59:19.171309Z","end":"2026-05-27T13:59:19.445734Z","steps":["trace[1906170566] 'count revisions from in-memory index tree' (duration: 274.211319ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:59:19.446313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.448658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-05-27T13:59:19.446368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.205746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-27T13:59:19.446408Z","caller":"traceutil/trace.go:171","msg":"trace[1653934707] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6891; }","duration":"122.263266ms","start":"2026-05-27T13:59:19.324134Z","end":"2026-05-27T13:59:19.446398Z","steps":["trace[1653934707] 'range keys from in-memory index tree' (duration: 122.078072ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:59:19.446408Z","caller":"traceutil/trace.go:171","msg":"trace[1726986766] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6891; }","duration":"126.61135ms","start":"2026-05-27T13:59:19.319777Z","end":"2026-05-27T13:59:19.446388Z","steps":["trace[1726986766] 'range keys from in-memory index tree' (duration: 126.231523ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:59:19.446998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.389559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-27T13:59:19.447039Z","caller":"traceutil/trace.go:171","msg":"trace[2112310622] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6891; }","duration":"121.46612ms","start":"2026-05-27T13:59:19.325563Z","end":"2026-05-27T13:59:19.447029Z","steps":["trace[2112310622] 'range keys from in-memory index tree' (duration: 120.90137ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:59:19.720108Z","caller":"traceutil/trace.go:171","msg":"trace[439274570] transaction","detail":"{read_only:false; response_revision:6892; number_of_response:1; }","duration":"268.746984ms","start":"2026-05-27T13:59:19.451328Z","end":"2026-05-27T13:59:19.720075Z","steps":["trace[439274570] 'process raft request' (duration: 268.59563ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:59:20.144201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.185926ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:59:20.144382Z","caller":"traceutil/trace.go:171","msg":"trace[2026390401] linearizableReadLoop","detail":"{readStateIndex:7152; appliedIndex:7150; }","duration":"671.830178ms","start":"2026-05-27T13:59:19.472539Z","end":"2026-05-27T13:59:20.144369Z","steps":["trace[2026390401] 'read index received' (duration: 247.513291ms)","trace[2026390401] 'applied index is now lower than readState.Index' (duration: 424.316157ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:59:20.144422Z","caller":"traceutil/trace.go:171","msg":"trace[1193373277] transaction","detail":"{read_only:false; response_revision:6895; number_of_response:1; }","duration":"559.843942ms","start":"2026-05-27T13:59:19.584558Z","end":"2026-05-27T13:59:20.144402Z","steps":["trace[1193373277] 'process raft request' (duration: 559.78141ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:59:20.144427Z","caller":"traceutil/trace.go:171","msg":"trace[510199529] transaction","detail":"{read_only:false; response_revision:6894; number_of_response:1; }","duration":"692.516659ms","start":"2026-05-27T13:59:19.451877Z","end":"2026-05-27T13:59:20.144393Z","steps":["trace[510199529] 'process raft request' (duration: 692.399597ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:59:20.144507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"671.968061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-27T13:59:20.144531Z","caller":"traceutil/trace.go:171","msg":"trace[630255762] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6895; }","duration":"672.023961ms","start":"2026-05-27T13:59:19.472499Z","end":"2026-05-27T13:59:20.144523Z","steps":["trace[630255762] 'agreement among raft nodes before linearized reading' (duration: 671.922179ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:59:20.144533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:59:19.584537Z","time spent":"559.930972ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:59:20.144554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:59:19.472479Z","time spent":"672.069421ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-27T13:59:20.14459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:59:19.451847Z","time spent":"692.652063ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:59:20.14465Z","caller":"traceutil/trace.go:171","msg":"trace[1500918345] transaction","detail":"{read_only:false; response_revision:6893; number_of_response:1; }","duration":"692.892897ms","start":"2026-05-27T13:59:19.451743Z","end":"2026-05-27T13:59:20.144636Z","steps":["trace[1500918345] 'process raft request' (duration: 590.202101ms)","trace[1500918345] 'compare' (duration: 101.904891ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:59:20.144801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:59:19.451727Z","time spent":"693.052459ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:59:21.874735Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.381063772s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-27T13:59:21.941128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.447265258s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-05-27T13:59:21.942479Z","caller":"traceutil/trace.go:171","msg":"trace[155626026] transaction","detail":"{read_only:false; response_revision:6896; number_of_response:1; }","duration":"1.859271015s","start":"2026-05-27T13:59:20.083175Z","end":"2026-05-27T13:59:21.942446Z","steps":["trace[155626026] 'process raft request' (duration: 1.858261075s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:59:21.942669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:59:20.08315Z","time spent":"1.859414467s","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:59:21.980554Z","caller":"traceutil/trace.go:171","msg":"trace[1555717103] transaction","detail":"{read_only:false; response_revision:6897; number_of_response:1; }","duration":"1.847676508s","start":"2026-05-27T13:59:20.132847Z","end":"2026-05-27T13:59:21.980523Z","steps":["trace[1555717103] 'process raft request' (duration: 1.809583349s)","trace[1555717103] 'compare' (duration: 37.777433ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:59:21.980714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:59:20.132827Z","time spent":"1.847799261s","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:59:21.98116Z","caller":"traceutil/trace.go:171","msg":"trace[1213649748] transaction","detail":"{read_only:false; response_revision:6898; number_of_response:1; }","duration":"1.828036856s","start":"2026-05-27T13:59:20.15311Z","end":"2026-05-27T13:59:21.981147Z","steps":["trace[1213649748] 'process raft request' (duration: 1.827367243s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:59:21.981328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:59:20.153088Z","time spent":"1.82818759s","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T13:59:21.981463Z","caller":"traceutil/trace.go:171","msg":"trace[567196696] linearizableReadLoop","detail":"{readStateIndex:7156; appliedIndex:7153; }","duration":"1.837040601s","start":"2026-05-27T13:59:20.144402Z","end":"2026-05-27T13:59:21.981443Z","steps":["trace[567196696] 'read index received' (duration: 349.427789ms)","trace[567196696] 'applied index is now lower than readState.Index' (duration: 1.487612012s)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:59:21.981529Z","caller":"traceutil/trace.go:171","msg":"trace[343744890] transaction","detail":"{read_only:false; response_revision:6899; number_of_response:1; }","duration":"1.497026864s","start":"2026-05-27T13:59:20.484477Z","end":"2026-05-27T13:59:21.981504Z","steps":["trace[343744890] 'process raft request' (duration: 1.496501454s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:59:21.981634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:59:20.484445Z","time spent":"1.497139538s","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:59:21.982033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.748258056s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T13:59:21.9821Z","caller":"traceutil/trace.go:171","msg":"trace[1936356305] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:6900; }","duration":"1.748362069s","start":"2026-05-27T13:59:20.23372Z","end":"2026-05-27T13:59:21.982082Z","steps":["trace[1936356305] 'agreement among raft nodes before linearized reading' (duration: 1.748254127s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:59:21.982159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:59:20.233698Z","time spent":"1.74844295s","remote":"127.0.0.1:44952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":31,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-27T13:59:21.982198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.86914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-27T13:59:21.982252Z","caller":"traceutil/trace.go:171","msg":"trace[1602519615] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6900; }","duration":"257.974051ms","start":"2026-05-27T13:59:21.724263Z","end":"2026-05-27T13:59:21.982237Z","steps":["trace[1602519615] 'agreement among raft nodes before linearized reading' (duration: 257.792207ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:59:21.9824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.393006918s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-27T13:59:21.982442Z","caller":"traceutil/trace.go:171","msg":"trace[542723132] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6900; }","duration":"2.393045698s","start":"2026-05-27T13:59:19.589386Z","end":"2026-05-27T13:59:21.982432Z","steps":["trace[542723132] 'agreement among raft nodes before linearized reading' (duration: 2.39212477s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:59:21.982476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:59:19.589347Z","time spent":"2.393118489s","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-27T13:59:21.982585Z","caller":"traceutil/trace.go:171","msg":"trace[765491083] transaction","detail":"{read_only:false; response_revision:6900; number_of_response:1; }","duration":"642.251506ms","start":"2026-05-27T13:59:21.340322Z","end":"2026-05-27T13:59:21.982574Z","steps":["trace[765491083] 'process raft request' (duration: 641.071033ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:59:21.982666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:59:21.340297Z","time spent":"642.315339ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:59:21.98275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.646643962s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:59:21.982778Z","caller":"traceutil/trace.go:171","msg":"trace[375911907] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6900; }","duration":"1.646719774s","start":"2026-05-27T13:59:20.336051Z","end":"2026-05-27T13:59:21.98277Z","steps":["trace[375911907] 'agreement among raft nodes before linearized reading' (duration: 1.646678073s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:59:21.982806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:59:20.33603Z","time spent":"1.646770374s","remote":"127.0.0.1:37092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-27T13:59:21.982962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.455816885s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:59:21.982988Z","caller":"traceutil/trace.go:171","msg":"trace[1946197004] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6900; }","duration":"1.455876296s","start":"2026-05-27T13:59:20.527106Z","end":"2026-05-27T13:59:21.982982Z","steps":["trace[1946197004] 'agreement among raft nodes before linearized reading' (duration: 1.455839255s)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:59:21.983005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:59:20.527085Z","time spent":"1.455916026s","remote":"127.0.0.1:37084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-27T13:59:21.985887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.565906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-05-27T13:59:21.98595Z","caller":"traceutil/trace.go:171","msg":"trace[766545867] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6900; }","duration":"532.665019ms","start":"2026-05-27T13:59:21.453272Z","end":"2026-05-27T13:59:21.985937Z","steps":["trace[766545867] 'agreement among raft nodes before linearized reading' (duration: 529.072728ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:59:21.985985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:59:21.453256Z","time spent":"532.72135ms","remote":"127.0.0.1:37272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-05-27T13:59:36.314646Z","caller":"traceutil/trace.go:171","msg":"trace[2135507490] transaction","detail":"{read_only:false; response_revision:6977; number_of_response:1; }","duration":"114.690941ms","start":"2026-05-27T13:59:36.199935Z","end":"2026-05-27T13:59:36.314626Z","steps":["trace[2135507490] 'process raft request' (duration: 114.417445ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:59:42.450975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.832938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-27T13:59:42.451199Z","caller":"traceutil/trace.go:171","msg":"trace[1779084011] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7011; }","duration":"106.071662ms","start":"2026-05-27T13:59:42.345097Z","end":"2026-05-27T13:59:42.451169Z","steps":["trace[1779084011] 'agreement among raft nodes before linearized reading' (duration: 105.499692ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T14:00:36.875184Z","caller":"traceutil/trace.go:171","msg":"trace[2104584110] transaction","detail":"{read_only:false; response_revision:7306; number_of_response:1; }","duration":"114.664055ms","start":"2026-05-27T14:00:36.760482Z","end":"2026-05-27T14:00:36.875146Z","steps":["trace[2104584110] 'process raft request' (duration: 88.145298ms)","trace[2104584110] 'compare' (duration: 26.359941ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T14:00:53.53146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.9442ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T14:00:53.531861Z","caller":"traceutil/trace.go:171","msg":"trace[802318512] transaction","detail":"{read_only:false; response_revision:7387; number_of_response:1; }","duration":"357.766684ms","start":"2026-05-27T14:00:53.17407Z","end":"2026-05-27T14:00:53.531836Z","steps":["trace[802318512] 'compare' (duration: 347.787724ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T14:00:53.531956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T14:00:53.174045Z","time spent":"357.859948ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T14:00:53.553528Z","caller":"traceutil/trace.go:171","msg":"trace[1957864041] transaction","detail":"{read_only:false; response_revision:7388; number_of_response:1; }","duration":"378.287642ms","start":"2026-05-27T14:00:53.17521Z","end":"2026-05-27T14:00:53.553498Z","steps":["trace[1957864041] 'process raft request' (duration: 378.000252ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T14:00:53.553903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T14:00:53.175197Z","time spent":"378.390265ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T14:00:54.825383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.166069ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T14:00:54.825546Z","caller":"traceutil/trace.go:171","msg":"trace[207562950] transaction","detail":"{read_only:false; response_revision:7391; number_of_response:1; }","duration":"256.94214ms","start":"2026-05-27T14:00:54.568583Z","end":"2026-05-27T14:00:54.825525Z","steps":["trace[207562950] 'process raft request' (duration: 34.555564ms)","trace[207562950] 'compare' (duration: 222.072696ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T14:00:54.864667Z","caller":"traceutil/trace.go:171","msg":"trace[779804457] transaction","detail":"{read_only:false; response_revision:7392; number_of_response:1; }","duration":"293.935978ms","start":"2026-05-27T14:00:54.570706Z","end":"2026-05-27T14:00:54.864642Z","steps":["trace[779804457] 'process raft request' (duration: 293.746911ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T14:00:54.864722Z","caller":"traceutil/trace.go:171","msg":"trace[1968474308] linearizableReadLoop","detail":"{readStateIndex:7671; appliedIndex:7669; }","duration":"192.211461ms","start":"2026-05-27T14:00:54.672493Z","end":"2026-05-27T14:00:54.864704Z","steps":["trace[1968474308] 'read index received' (duration: 191.943082ms)","trace[1968474308] 'applied index is now lower than readState.Index' (duration: 266.899µs)"],"step_count":2} {"level":"warn","ts":"2026-05-27T14:00:54.865009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.497671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3315"} {"level":"info","ts":"2026-05-27T14:00:54.865051Z","caller":"traceutil/trace.go:171","msg":"trace[883227639] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:7393; }","duration":"192.574024ms","start":"2026-05-27T14:00:54.672464Z","end":"2026-05-27T14:00:54.865038Z","steps":["trace[883227639] 'agreement among raft nodes before linearized reading' (duration: 192.286204ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T14:00:54.865065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.261519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-27T14:00:54.865123Z","caller":"traceutil/trace.go:171","msg":"trace[1617198107] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7393; }","duration":"113.363151ms","start":"2026-05-27T14:00:54.75175Z","end":"2026-05-27T14:00:54.865113Z","steps":["trace[1617198107] 'agreement among raft nodes before linearized reading' (duration: 113.198736ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T14:00:54.864814Z","caller":"traceutil/trace.go:171","msg":"trace[188693224] transaction","detail":"{read_only:false; response_revision:7393; number_of_response:1; }","duration":"293.962758ms","start":"2026-05-27T14:00:54.570797Z","end":"2026-05-27T14:00:54.864759Z","steps":["trace[188693224] 'process raft request' (duration: 293.802433ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T14:00:57.337838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.527839ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T14:00:57.337939Z","caller":"traceutil/trace.go:171","msg":"trace[2072357055] transaction","detail":"{read_only:false; response_revision:7403; number_of_response:1; }","duration":"507.020989ms","start":"2026-05-27T14:00:56.830898Z","end":"2026-05-27T14:00:57.337919Z","steps":["trace[2072357055] 'process raft request' (duration: 86.330546ms)","trace[2072357055] 'compare' (duration: 420.062242ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T14:00:57.338003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T14:00:56.83087Z","time spent":"507.100141ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T14:00:57.686564Z","caller":"traceutil/trace.go:171","msg":"trace[1721459520] linearizableReadLoop","detail":"{readStateIndex:7684; appliedIndex:7681; }","duration":"785.298877ms","start":"2026-05-27T14:00:56.901242Z","end":"2026-05-27T14:00:57.686541Z","steps":["trace[1721459520] 'read index received' (duration: 16.012852ms)","trace[1721459520] 'applied index is now lower than readState.Index' (duration: 769.284865ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T14:00:57.686625Z","caller":"traceutil/trace.go:171","msg":"trace[1960722999] transaction","detail":"{read_only:false; response_revision:7405; number_of_response:1; }","duration":"815.244922ms","start":"2026-05-27T14:00:56.871348Z","end":"2026-05-27T14:00:57.686593Z","steps":["trace[1960722999] 'process raft request' (duration: 814.996424ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T14:00:57.686689Z","caller":"traceutil/trace.go:171","msg":"trace[939134437] transaction","detail":"{read_only:false; response_revision:7404; number_of_response:1; }","duration":"815.949726ms","start":"2026-05-27T14:00:56.870719Z","end":"2026-05-27T14:00:57.686669Z","steps":["trace[939134437] 'process raft request' (duration: 758.74233ms)","trace[939134437] 'compare' (duration: 56.580065ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T14:00:57.68682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T14:00:56.870701Z","time spent":"816.037259ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T14:00:57.686839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"785.387411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-27T14:00:57.687094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.801855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-27T14:00:57.687103Z","caller":"traceutil/trace.go:171","msg":"trace[1309153307] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7406; }","duration":"785.69696ms","start":"2026-05-27T14:00:56.901389Z","end":"2026-05-27T14:00:57.687086Z","steps":["trace[1309153307] 'agreement among raft nodes before linearized reading' (duration: 785.347419ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T14:00:57.687137Z","caller":"traceutil/trace.go:171","msg":"trace[1380855990] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7406; }","duration":"431.878338ms","start":"2026-05-27T14:00:57.255246Z","end":"2026-05-27T14:00:57.687125Z","steps":["trace[1380855990] 'agreement among raft nodes before linearized reading' (duration: 431.785855ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T14:00:57.687172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T14:00:57.255218Z","time spent":"431.947251ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-27T14:00:57.687174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T14:00:56.901367Z","time spent":"785.774804ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-27T14:00:57.687048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"785.792984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-05-27T14:00:57.687323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.876961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T14:00:57.687361Z","caller":"traceutil/trace.go:171","msg":"trace[1061629983] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:7406; }","duration":"497.942393ms","start":"2026-05-27T14:00:57.189408Z","end":"2026-05-27T14:00:57.68735Z","steps":["trace[1061629983] 'agreement among raft nodes before linearized reading' (duration: 497.87635ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T14:00:57.687118Z","caller":"traceutil/trace.go:171","msg":"trace[1359916798] transaction","detail":"{read_only:false; response_revision:7406; number_of_response:1; }","duration":"649.409356ms","start":"2026-05-27T14:00:57.037664Z","end":"2026-05-27T14:00:57.687074Z","steps":["trace[1359916798] 'process raft request' (duration: 648.836757ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T14:00:57.687396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T14:00:57.189383Z","time spent":"498.003875ms","remote":"127.0.0.1:60422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true "} {"level":"warn","ts":"2026-05-27T14:00:57.687409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.599952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T14:00:57.687465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T14:00:57.03764Z","time spent":"649.774678ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T14:00:57.687322Z","caller":"traceutil/trace.go:171","msg":"trace[1796652929] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7406; }","duration":"786.114676ms","start":"2026-05-27T14:00:56.901193Z","end":"2026-05-27T14:00:57.687307Z","steps":["trace[1796652929] 'agreement among raft nodes before linearized reading' (duration: 785.505135ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T14:00:57.687576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T14:00:56.901172Z","time spent":"786.393994ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-27T14:00:57.687569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T14:00:56.871331Z","time spent":"815.372326ms","remote":"127.0.0.1:37346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T14:00:57.687221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.133519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" ","response":"range_response_count:1 size:1321"} {"level":"info","ts":"2026-05-27T14:00:57.687719Z","caller":"traceutil/trace.go:171","msg":"trace[1481356929] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-keystone-default-user; range_end:; response_count:1; response_revision:7406; }","duration":"333.662725ms","start":"2026-05-27T14:00:57.354037Z","end":"2026-05-27T14:00:57.6877Z","steps":["trace[1481356929] 'agreement among raft nodes before linearized reading' (duration: 332.994343ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T14:00:57.687781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T14:00:57.354022Z","time spent":"333.743529ms","remote":"127.0.0.1:37192","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":1345,"request content":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" "} {"level":"info","ts":"2026-05-27T14:00:57.687769Z","caller":"traceutil/trace.go:171","msg":"trace[2051270565] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7406; }","duration":"160.832651ms","start":"2026-05-27T14:00:57.526695Z","end":"2026-05-27T14:00:57.687527Z","steps":["trace[2051270565] 'agreement among raft nodes before linearized reading' (duration: 160.609774ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T14:01:01.785552Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5524} {"level":"info","ts":"2026-05-27T14:01:01.88831Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5524,"took":"99.03569ms","hash":1960587907,"current-db-size-bytes":51916800,"current-db-size":"52 MB","current-db-size-in-use-bytes":18468864,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-27T14:01:01.888362Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1960587907,"revision":5524,"compact-revision":2901} {"level":"info","ts":"2026-05-27T14:01:17.528957Z","caller":"traceutil/trace.go:171","msg":"trace[190044365] transaction","detail":"{read_only:false; response_revision:7506; number_of_response:1; }","duration":"119.93441ms","start":"2026-05-27T14:01:17.40896Z","end":"2026-05-27T14:01:17.528894Z","steps":["trace[190044365] 'process raft request' (duration: 119.674671ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T14:01:58.189149Z","caller":"traceutil/trace.go:171","msg":"trace[1331156002] linearizableReadLoop","detail":"{readStateIndex:8004; appliedIndex:8003; }","duration":"129.907809ms","start":"2026-05-27T14:01:58.059221Z","end":"2026-05-27T14:01:58.189129Z","steps":["trace[1331156002] 'read index received' (duration: 129.662692ms)","trace[1331156002] 'applied index is now lower than readState.Index' (duration: 244.197µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T14:01:58.189432Z","caller":"traceutil/trace.go:171","msg":"trace[1209589551] transaction","detail":"{read_only:false; response_revision:7712; number_of_response:1; }","duration":"145.428272ms","start":"2026-05-27T14:01:58.043987Z","end":"2026-05-27T14:01:58.189415Z","steps":["trace[1209589551] 'process raft request' (duration: 144.974738ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T14:01:58.189694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.377394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-05-27T14:01:58.189765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.141378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-27T14:01:58.189778Z","caller":"traceutil/trace.go:171","msg":"trace[1715236272] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7712; }","duration":"130.480778ms","start":"2026-05-27T14:01:58.059276Z","end":"2026-05-27T14:01:58.189757Z","steps":["trace[1715236272] 'agreement among raft nodes before linearized reading' (duration: 130.246681ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T14:01:58.189824Z","caller":"traceutil/trace.go:171","msg":"trace[356799387] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7712; }","duration":"130.21674ms","start":"2026-05-27T14:01:58.059591Z","end":"2026-05-27T14:01:58.189807Z","steps":["trace[356799387] 'agreement among raft nodes before linearized reading' (duration: 130.034064ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T14:01:58.189824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.852406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/kube-system/\" range_end:\"/registry/services/specs/kube-system0\" limit:500 ","response":"range_response_count:7 size:9463"} {"level":"info","ts":"2026-05-27T14:01:58.18988Z","caller":"traceutil/trace.go:171","msg":"trace[818867819] range","detail":"{range_begin:/registry/services/specs/kube-system/; range_end:/registry/services/specs/kube-system0; response_count:7; response_revision:7712; }","duration":"100.937088ms","start":"2026-05-27T14:01:58.088926Z","end":"2026-05-27T14:01:58.189863Z","steps":["trace[818867819] 'agreement among raft nodes before linearized reading' (duration: 100.748872ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T14:01:58.190023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.775096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-27T14:01:58.190126Z","caller":"traceutil/trace.go:171","msg":"trace[1281141550] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7712; }","duration":"130.909831ms","start":"2026-05-27T14:01:58.059191Z","end":"2026-05-27T14:01:58.190101Z","steps":["trace[1281141550] 'agreement among raft nodes before linearized reading' (duration: 130.709994ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T14:01:58.190771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.756386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-27T14:01:58.190845Z","caller":"traceutil/trace.go:171","msg":"trace[978772741] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7712; }","duration":"130.864729ms","start":"2026-05-27T14:01:58.059961Z","end":"2026-05-27T14:01:58.190826Z","steps":["trace[978772741] 'agreement among raft nodes before linearized reading' (duration: 129.62567ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T14:02:40.412856Z","caller":"traceutil/trace.go:171","msg":"trace[347073530] linearizableReadLoop","detail":"{readStateIndex:8224; appliedIndex:8223; }","duration":"215.8055ms","start":"2026-05-27T14:02:40.197028Z","end":"2026-05-27T14:02:40.412833Z","steps":["trace[347073530] 'read index received' (duration: 214.551463ms)","trace[347073530] 'applied index is now lower than readState.Index' (duration: 1.252117ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T14:02:40.4131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.165694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-h4ghw\" ","response":"range_response_count:1 size:5487"} {"level":"warn","ts":"2026-05-27T14:02:40.413092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.036467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T14:02:40.413154Z","caller":"traceutil/trace.go:171","msg":"trace[265315228] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-h4ghw; range_end:; response_count:1; response_revision:7923; }","duration":"187.256296ms","start":"2026-05-27T14:02:40.225881Z","end":"2026-05-27T14:02:40.413137Z","steps":["trace[265315228] 'agreement among raft nodes before linearized reading' (duration: 187.097182ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T14:02:40.413175Z","caller":"traceutil/trace.go:171","msg":"trace[1240064700] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:7923; }","duration":"216.16484ms","start":"2026-05-27T14:02:40.196988Z","end":"2026-05-27T14:02:40.413153Z","steps":["trace[1240064700] 'agreement among raft nodes before linearized reading' (duration: 215.992256ms)"],"step_count":1}