{"level":"warn","ts":"2026-04-22T05:59:33.75661Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-22T05:59:33.756691Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.227:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.227:2380","--initial-cluster=instance=https://199.204.45.227:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.227:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.227:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-22T05:59:33.75675Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-22T05:59:33.756762Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-04-22T05:59:33.756779Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-22T05:59:33.757668Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"]} {"level":"info","ts":"2026-04-22T05:59:33.757745Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.227:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-22T05:59:33.762943Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.99335ms"} {"level":"info","ts":"2026-04-22T05:59:33.776782Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"572db18442eba1c2","cluster-id":"fb1028a037bf3cd6"} {"level":"info","ts":"2026-04-22T05:59:33.776882Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=()"} {"level":"info","ts":"2026-04-22T05:59:33.776918Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 0"} {"level":"info","ts":"2026-04-22T05:59:33.776931Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 572db18442eba1c2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-22T05:59:33.776942Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 1"} {"level":"info","ts":"2026-04-22T05:59:33.776984Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"warn","ts":"2026-04-22T05:59:33.783175Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-22T05:59:33.785388Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-22T05:59:33.789507Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-22T05:59:33.791629Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"572db18442eba1c2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-22T05:59:33.794223Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"572db18442eba1c2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-22T05:59:33.794393Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-22T05:59:33.79449Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-22T05:59:33.794519Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-22T05:59:33.798225Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"info","ts":"2026-04-22T05:59:33.798636Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","added-peer-id":"572db18442eba1c2","added-peer-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-04-22T05:59:33.799327Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-22T05:59:33.799632Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"572db18442eba1c2","initial-advertise-peer-urls":["https://199.204.45.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-22T05:59:33.799666Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-22T05:59:33.800089Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-04-22T05:59:33.800132Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-04-22T05:59:34.077444Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 is starting a new election at term 1"} {"level":"info","ts":"2026-04-22T05:59:34.077563Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-22T05:59:34.077608Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgPreVoteResp from 572db18442eba1c2 at term 1"} {"level":"info","ts":"2026-04-22T05:59:34.077655Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became candidate at term 2"} {"level":"info","ts":"2026-04-22T05:59:34.077688Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgVoteResp from 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-04-22T05:59:34.077735Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became leader at term 2"} {"level":"info","ts":"2026-04-22T05:59:34.077775Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 572db18442eba1c2 elected leader 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-04-22T05:59:34.134501Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"572db18442eba1c2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.227:2379]}","request-path":"/0/members/572db18442eba1c2/attributes","cluster-id":"fb1028a037bf3cd6","publish-timeout":"7s"} {"level":"info","ts":"2026-04-22T05:59:34.134965Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T05:59:34.135227Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T05:59:34.135489Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T05:59:34.135697Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-22T05:59:34.135796Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-22T05:59:34.138404Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-22T05:59:34.139262Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.227:2379"} {"level":"info","ts":"2026-04-22T05:59:34.140494Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T05:59:34.140629Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T05:59:34.140742Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-04-22T05:59:39.850357Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656052181030441872,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-22T05:59:39.996781Z","caller":"traceutil/trace.go:171","msg":"trace[1426698864] transaction","detail":"{read_only:false; response_revision:293; number_of_response:1; }","duration":"657.208175ms","start":"2026-04-22T05:59:39.33955Z","end":"2026-04-22T05:59:39.996758Z","steps":["trace[1426698864] 'process raft request' (duration: 656.936559ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T05:59:39.996757Z","caller":"traceutil/trace.go:171","msg":"trace[1173295275] linearizableReadLoop","detail":"{readStateIndex:303; appliedIndex:302; }","duration":"646.433395ms","start":"2026-04-22T05:59:39.350296Z","end":"2026-04-22T05:59:39.99673Z","steps":["trace[1173295275] 'read index received' (duration: 646.274822ms)","trace[1173295275] 'applied index is now lower than readState.Index' (duration: 157.243µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T05:59:39.996928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.610698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-22T05:59:39.997048Z","caller":"traceutil/trace.go:171","msg":"trace[1517251437] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:293; }","duration":"646.770381ms","start":"2026-04-22T05:59:39.35026Z","end":"2026-04-22T05:59:39.997031Z","steps":["trace[1517251437] 'agreement among raft nodes before linearized reading' (duration: 646.566877ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T05:59:39.997101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T05:59:39.350219Z","time spent":"646.869223ms","remote":"127.0.0.1:41690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-22T05:59:39.99732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T05:59:39.339522Z","time spent":"657.332157ms","remote":"127.0.0.1:41766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":170,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-22T05:59:40.497249Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656052181030441877,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T05:59:40.997872Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656052181030441877,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T05:59:41.069163Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.072583518s","expected-duration":"1s"} {"level":"info","ts":"2026-04-22T05:59:41.070401Z","caller":"traceutil/trace.go:171","msg":"trace[231967453] transaction","detail":"{read_only:false; number_of_response:0; response_revision:293; }","duration":"1.141345002s","start":"2026-04-22T05:59:39.929033Z","end":"2026-04-22T05:59:41.070378Z","steps":["trace[231967453] 'process raft request' (duration: 1.141306211s)"],"step_count":1} {"level":"info","ts":"2026-04-22T05:59:41.07042Z","caller":"traceutil/trace.go:171","msg":"trace[1641480989] transaction","detail":"{read_only:false; number_of_response:0; response_revision:293; }","duration":"1.141508184s","start":"2026-04-22T05:59:39.928873Z","end":"2026-04-22T05:59:41.070381Z","steps":["trace[1641480989] 'process raft request' (duration: 1.140524346s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T05:59:41.070528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T05:59:39.929012Z","time spent":"1.141449824s","remote":"127.0.0.1:41752","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-22T05:59:41.070547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T05:59:39.928854Z","time spent":"1.141631528s","remote":"127.0.0.1:41752","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T05:59:41.070678Z","caller":"traceutil/trace.go:171","msg":"trace[1624031900] transaction","detail":"{read_only:false; number_of_response:0; response_revision:293; }","duration":"1.141655078s","start":"2026-04-22T05:59:39.929014Z","end":"2026-04-22T05:59:41.070669Z","steps":["trace[1624031900] 'process raft request' (duration: 1.14126935s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T05:59:41.070737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T05:59:39.928978Z","time spent":"1.141729019s","remote":"127.0.0.1:41752","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T05:59:41.213195Z","caller":"traceutil/trace.go:171","msg":"trace[411067578] linearizableReadLoop","detail":"{readStateIndex:308; appliedIndex:303; }","duration":"1.216203823s","start":"2026-04-22T05:59:39.996966Z","end":"2026-04-22T05:59:41.213169Z","steps":["trace[411067578] 'read index received' (duration: 1.072444706s)","trace[411067578] 'applied index is now lower than readState.Index' (duration: 143.757927ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T05:59:41.213348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.838259791s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T05:59:41.213351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.529991677s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T05:59:41.213389Z","caller":"traceutil/trace.go:171","msg":"trace[673971518] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:295; }","duration":"1.838346093s","start":"2026-04-22T05:59:39.375032Z","end":"2026-04-22T05:59:41.213378Z","steps":["trace[673971518] 'agreement among raft nodes before linearized reading' (duration: 1.838274842s)"],"step_count":1} {"level":"info","ts":"2026-04-22T05:59:41.213404Z","caller":"traceutil/trace.go:171","msg":"trace[1693934698] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:295; }","duration":"1.530104489s","start":"2026-04-22T05:59:39.683282Z","end":"2026-04-22T05:59:41.213387Z","steps":["trace[1693934698] 'agreement among raft nodes before linearized reading' (duration: 1.529983876s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T05:59:41.213357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.74399496s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T05:59:41.213422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.356448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-22T05:59:41.21344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T05:59:39.683262Z","time spent":"1.53017032s","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-22T05:59:41.213482Z","caller":"traceutil/trace.go:171","msg":"trace[712028496] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"1.212161555s","start":"2026-04-22T05:59:40.001311Z","end":"2026-04-22T05:59:41.213473Z","steps":["trace[712028496] 'process raft request' (duration: 1.211803107s)"],"step_count":1} {"level":"info","ts":"2026-04-22T05:59:41.213492Z","caller":"traceutil/trace.go:171","msg":"trace[895011186] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:295; }","duration":"1.744154512s","start":"2026-04-22T05:59:39.469295Z","end":"2026-04-22T05:59:41.21345Z","steps":["trace[895011186] 'agreement among raft nodes before linearized reading' (duration: 1.743984529s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T05:59:41.213527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.392453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5897"} {"level":"warn","ts":"2026-04-22T05:59:41.213546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T05:59:40.001296Z","time spent":"1.212214966s","remote":"127.0.0.1:60238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":420,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T05:59:41.213561Z","caller":"traceutil/trace.go:171","msg":"trace[1873823625] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:295; }","duration":"141.442294ms","start":"2026-04-22T05:59:41.072111Z","end":"2026-04-22T05:59:41.213553Z","steps":["trace[1873823625] 'agreement among raft nodes before linearized reading' (duration: 141.390483ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T05:59:41.213576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T05:59:39.46928Z","time spent":"1.744245584s","remote":"127.0.0.1:41600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-22T05:59:41.213619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.788911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:2920"} {"level":"info","ts":"2026-04-22T05:59:41.213677Z","caller":"traceutil/trace.go:171","msg":"trace[1054724643] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:295; }","duration":"141.895943ms","start":"2026-04-22T05:59:41.071762Z","end":"2026-04-22T05:59:41.213658Z","steps":["trace[1054724643] 'agreement among raft nodes before linearized reading' (duration: 141.794461ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T05:59:41.213718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.356777831s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T05:59:41.213751Z","caller":"traceutil/trace.go:171","msg":"trace[2017614741] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:295; }","duration":"1.356896843s","start":"2026-04-22T05:59:39.856844Z","end":"2026-04-22T05:59:41.213741Z","steps":["trace[2017614741] 'agreement among raft nodes before linearized reading' (duration: 1.356812072s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T05:59:41.213762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.104586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:5513"} {"level":"warn","ts":"2026-04-22T05:59:41.21339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.286520518s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:2920"} {"level":"warn","ts":"2026-04-22T05:59:41.213439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T05:59:39.375017Z","time spent":"1.838410884s","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-22T05:59:41.2138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T05:59:39.856814Z","time spent":"1.356970044s","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-22T05:59:41.213833Z","caller":"traceutil/trace.go:171","msg":"trace[1832820179] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:295; }","duration":"142.210819ms","start":"2026-04-22T05:59:41.071612Z","end":"2026-04-22T05:59:41.213823Z","steps":["trace[1832820179] 'agreement among raft nodes before linearized reading' (duration: 142.119857ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T05:59:41.213858Z","caller":"traceutil/trace.go:171","msg":"trace[253315136] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:295; }","duration":"1.286996906s","start":"2026-04-22T05:59:39.926849Z","end":"2026-04-22T05:59:41.213846Z","steps":["trace[253315136] 'agreement among raft nodes before linearized reading' (duration: 1.286379764s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T05:59:41.21394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T05:59:39.926794Z","time spent":"1.287132138s","remote":"127.0.0.1:41752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":2943,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"info","ts":"2026-04-22T05:59:41.21348Z","caller":"traceutil/trace.go:171","msg":"trace[1315651427] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:295; }","duration":"352.445409ms","start":"2026-04-22T05:59:40.861018Z","end":"2026-04-22T05:59:41.213463Z","steps":["trace[1315651427] 'agreement among raft nodes before linearized reading' (duration: 352.350758ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T05:59:41.214093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T05:59:40.860999Z","time spent":"353.050692ms","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-22T05:59:41.213202Z","caller":"traceutil/trace.go:171","msg":"trace[925796631] transaction","detail":"{read_only:false; response_revision:294; number_of_response:1; }","duration":"1.212388288s","start":"2026-04-22T05:59:40.000778Z","end":"2026-04-22T05:59:41.213167Z","steps":["trace[925796631] 'process raft request' (duration: 1.212196075s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T05:59:41.214701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T05:59:40.000758Z","time spent":"1.213601201s","remote":"127.0.0.1:41766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":192,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T06:00:06.311769Z","caller":"traceutil/trace.go:171","msg":"trace[713477574] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"105.008916ms","start":"2026-04-22T06:00:06.206744Z","end":"2026-04-22T06:00:06.311753Z","steps":["trace[713477574] 'process raft request' (duration: 104.752743ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:00:06.765449Z","caller":"traceutil/trace.go:171","msg":"trace[1875680012] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"373.263582ms","start":"2026-04-22T06:00:06.392158Z","end":"2026-04-22T06:00:06.765422Z","steps":["trace[1875680012] 'process raft request' (duration: 372.734145ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:06.765688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:06.392132Z","time spent":"373.375843ms","remote":"127.0.0.1:41626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208470,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:00:06.766016Z","caller":"traceutil/trace.go:171","msg":"trace[967690945] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"339.174512ms","start":"2026-04-22T06:00:06.426785Z","end":"2026-04-22T06:00:06.765959Z","steps":["trace[967690945] 'process raft request' (duration: 339.086481ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:00:06.766243Z","caller":"traceutil/trace.go:171","msg":"trace[696642055] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:610; }","duration":"355.006606ms","start":"2026-04-22T06:00:06.410327Z","end":"2026-04-22T06:00:06.765334Z","steps":["trace[696642055] 'read index received' (duration: 354.470658ms)","trace[696642055] 'applied index is now lower than readState.Index' (duration: 534.898µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:00:06.766292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.942847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:570105"} {"level":"info","ts":"2026-04-22T06:00:06.766409Z","caller":"traceutil/trace.go:171","msg":"trace[874340547] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:589; }","duration":"356.07207ms","start":"2026-04-22T06:00:06.410306Z","end":"2026-04-22T06:00:06.766378Z","steps":["trace[874340547] 'agreement among raft nodes before linearized reading' (duration: 355.223159ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:06.76646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:06.410274Z","time spent":"356.176411ms","remote":"127.0.0.1:41626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":93,"response count":1,"response size":570128,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" "} {"level":"warn","ts":"2026-04-22T06:00:06.766485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:06.426759Z","time spent":"339.403324ms","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T06:00:06.766664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.620818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:00:06.766695Z","caller":"traceutil/trace.go:171","msg":"trace[2129912973] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:590; }","duration":"295.909343ms","start":"2026-04-22T06:00:06.470776Z","end":"2026-04-22T06:00:06.766685Z","steps":["trace[2129912973] 'agreement among raft nodes before linearized reading' (duration: 295.634679ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:08.655905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.941287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:00:08.655992Z","caller":"traceutil/trace.go:171","msg":"trace[1958094815] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:599; }","duration":"148.076818ms","start":"2026-04-22T06:00:08.507898Z","end":"2026-04-22T06:00:08.655974Z","steps":["trace[1958094815] 'range keys from in-memory index tree' (duration: 147.854705ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:00:11.237493Z","caller":"traceutil/trace.go:171","msg":"trace[1149091250] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"128.697291ms","start":"2026-04-22T06:00:11.108769Z","end":"2026-04-22T06:00:11.237466Z","steps":["trace[1149091250] 'process raft request' (duration: 128.177374ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:00:11.468354Z","caller":"traceutil/trace.go:171","msg":"trace[1565410486] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"107.118787ms","start":"2026-04-22T06:00:11.361221Z","end":"2026-04-22T06:00:11.46834Z","steps":["trace[1565410486] 'process raft request' (duration: 69.72484ms)","trace[1565410486] 'compare' (duration: 37.111313ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:00:12.351466Z","caller":"traceutil/trace.go:171","msg":"trace[120048729] linearizableReadLoop","detail":"{readStateIndex:645; appliedIndex:644; }","duration":"328.332744ms","start":"2026-04-22T06:00:12.023105Z","end":"2026-04-22T06:00:12.351437Z","steps":["trace[120048729] 'read index received' (duration: 326.36759ms)","trace[120048729] 'applied index is now lower than readState.Index' (duration: 1.964064ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:00:12.351604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.473575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-4kvxn\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-22T06:00:12.351528Z","caller":"traceutil/trace.go:171","msg":"trace[455743915] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"604.700153ms","start":"2026-04-22T06:00:11.746804Z","end":"2026-04-22T06:00:12.351505Z","steps":["trace[455743915] 'process raft request' (duration: 604.052346ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:00:12.351638Z","caller":"traceutil/trace.go:171","msg":"trace[1134220903] range","detail":"{range_begin:/registry/pods/kube-system/cilium-4kvxn; range_end:; response_count:1; response_revision:622; }","duration":"328.561536ms","start":"2026-04-22T06:00:12.023065Z","end":"2026-04-22T06:00:12.351627Z","steps":["trace[1134220903] 'agreement among raft nodes before linearized reading' (duration: 328.474355ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:12.351852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:11.746775Z","time spent":"604.923146ms","remote":"127.0.0.1:41682","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T06:00:12.351858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:12.023049Z","time spent":"328.796539ms","remote":"127.0.0.1:41752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-4kvxn\" "} {"level":"warn","ts":"2026-04-22T06:00:14.194139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.547405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:00:14.19422Z","caller":"traceutil/trace.go:171","msg":"trace[590552463] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:624; }","duration":"582.676946ms","start":"2026-04-22T06:00:13.611525Z","end":"2026-04-22T06:00:14.194202Z","steps":["trace[590552463] 'range keys from in-memory index tree' (duration: 582.465984ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:14.194225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.580293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T06:00:14.194262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:13.611507Z","time spent":"582.743977ms","remote":"127.0.0.1:50454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-22T06:00:14.194279Z","caller":"traceutil/trace.go:171","msg":"trace[727174980] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:624; }","duration":"231.666794ms","start":"2026-04-22T06:00:13.962597Z","end":"2026-04-22T06:00:14.194264Z","steps":["trace[727174980] 'count revisions from in-memory index tree' (duration: 231.487651ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:14.194473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.696605247s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:00:14.194508Z","caller":"traceutil/trace.go:171","msg":"trace[201133955] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:624; }","duration":"1.696702878s","start":"2026-04-22T06:00:12.497796Z","end":"2026-04-22T06:00:14.194499Z","steps":["trace[201133955] 'range keys from in-memory index tree' (duration: 1.696533426s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:14.194535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:12.49778Z","time spent":"1.696748859s","remote":"127.0.0.1:41792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-04-22T06:00:14.194769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.855878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T06:00:14.194783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.100829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T06:00:14.194817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.301796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:00:14.194848Z","caller":"traceutil/trace.go:171","msg":"trace[916029687] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:624; }","duration":"232.20235ms","start":"2026-04-22T06:00:13.962629Z","end":"2026-04-22T06:00:14.194832Z","steps":["trace[916029687] 'range keys from in-memory index tree' (duration: 232.038648ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:00:14.19482Z","caller":"traceutil/trace.go:171","msg":"trace[27712707] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:624; }","duration":"582.94354ms","start":"2026-04-22T06:00:13.611861Z","end":"2026-04-22T06:00:14.194805Z","steps":["trace[27712707] 'count revisions from in-memory index tree' (duration: 582.779868ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:14.194987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.262874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T06:00:14.194993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.136611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:00:14.195019Z","caller":"traceutil/trace.go:171","msg":"trace[586995258] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:624; }","duration":"424.301996ms","start":"2026-04-22T06:00:13.770704Z","end":"2026-04-22T06:00:14.195006Z","steps":["trace[586995258] 'range keys from in-memory index tree' (duration: 424.225864ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:00:14.195033Z","caller":"traceutil/trace.go:171","msg":"trace[1442146858] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:624; }","duration":"557.185942ms","start":"2026-04-22T06:00:13.637835Z","end":"2026-04-22T06:00:14.195021Z","steps":["trace[1442146858] 'range keys from in-memory index tree' (duration: 557.05064ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:14.195046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:13.770698Z","time spent":"424.340596ms","remote":"127.0.0.1:50480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-22T06:00:14.195072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:13.637827Z","time spent":"557.234553ms","remote":"127.0.0.1:50460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-22T06:00:14.195129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.703836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:00:14.195223Z","caller":"traceutil/trace.go:171","msg":"trace[495564803] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:624; }","duration":"211.832208ms","start":"2026-04-22T06:00:13.983379Z","end":"2026-04-22T06:00:14.195211Z","steps":["trace[495564803] 'range keys from in-memory index tree' (duration: 211.638876ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:14.195234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:13.611839Z","time spent":"583.290615ms","remote":"127.0.0.1:50454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-22T06:00:14.195249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.605169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T06:00:14.195261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"713.460278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-22T06:00:14.195289Z","caller":"traceutil/trace.go:171","msg":"trace[2070983729] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:624; }","duration":"713.534409ms","start":"2026-04-22T06:00:13.481744Z","end":"2026-04-22T06:00:14.195279Z","steps":["trace[2070983729] 'range keys from in-memory index tree' (duration: 713.391118ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:14.195325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:13.48173Z","time spent":"713.5888ms","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-22T06:00:14.195357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.190266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T06:00:14.195391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.564723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:00:14.195398Z","caller":"traceutil/trace.go:171","msg":"trace[321173776] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:624; }","duration":"544.228526ms","start":"2026-04-22T06:00:13.651159Z","end":"2026-04-22T06:00:14.195387Z","steps":["trace[321173776] 'count revisions from in-memory index tree' (duration: 544.148976ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:00:14.195421Z","caller":"traceutil/trace.go:171","msg":"trace[987946178] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:624; }","duration":"211.613324ms","start":"2026-04-22T06:00:13.983794Z","end":"2026-04-22T06:00:14.195407Z","steps":["trace[987946178] 'range keys from in-memory index tree' (duration: 211.501823ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:14.195439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:13.651136Z","time spent":"544.294468ms","remote":"127.0.0.1:50474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-22T06:00:14.195456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.10066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T06:00:14.195472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"711.552925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-22T06:00:14.195502Z","caller":"traceutil/trace.go:171","msg":"trace[1959305211] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:624; }","duration":"711.601876ms","start":"2026-04-22T06:00:13.483889Z","end":"2026-04-22T06:00:14.195491Z","steps":["trace[1959305211] 'range keys from in-memory index tree' (duration: 711.498625ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:00:14.195433Z","caller":"traceutil/trace.go:171","msg":"trace[1151443050] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:624; }","duration":"424.66413ms","start":"2026-04-22T06:00:13.770604Z","end":"2026-04-22T06:00:14.195268Z","steps":["trace[1151443050] 'count revisions from in-memory index tree' (duration: 424.461688ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:00:14.195519Z","caller":"traceutil/trace.go:171","msg":"trace[1217821320] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:624; }","duration":"263.178421ms","start":"2026-04-22T06:00:13.932329Z","end":"2026-04-22T06:00:14.195507Z","steps":["trace[1217821320] 'count revisions from in-memory index tree' (duration: 263.063299ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:14.195528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:13.483879Z","time spent":"711.643367ms","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-22T06:00:14.195581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:13.770585Z","time spent":"424.949573ms","remote":"127.0.0.1:50480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-22T06:00:14.19559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.50716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T06:00:14.195153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"723.734632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-22T06:00:14.195621Z","caller":"traceutil/trace.go:171","msg":"trace[1723916645] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:624; }","duration":"544.579002ms","start":"2026-04-22T06:00:13.651033Z","end":"2026-04-22T06:00:14.195612Z","steps":["trace[1723916645] 'range keys from in-memory index tree' (duration: 544.355788ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:00:14.195641Z","caller":"traceutil/trace.go:171","msg":"trace[1971680352] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:624; }","duration":"724.236457ms","start":"2026-04-22T06:00:13.471393Z","end":"2026-04-22T06:00:14.195629Z","steps":["trace[1971680352] 'range keys from in-memory index tree' (duration: 723.665711ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:14.195653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:13.651012Z","time spent":"544.632992ms","remote":"127.0.0.1:50474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-22T06:00:14.195678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:13.471383Z","time spent":"724.284757ms","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-22T06:00:14.195685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.679089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:00:14.195713Z","caller":"traceutil/trace.go:171","msg":"trace[581236667] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:624; }","duration":"630.741641ms","start":"2026-04-22T06:00:13.564962Z","end":"2026-04-22T06:00:14.195704Z","steps":["trace[581236667] 'count revisions from in-memory index tree' (duration: 630.568258ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:14.195748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:13.564942Z","time spent":"630.798221ms","remote":"127.0.0.1:50432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"warn","ts":"2026-04-22T06:00:14.195785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.916577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T06:00:14.195229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"715.535314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-22T06:00:14.19583Z","caller":"traceutil/trace.go:171","msg":"trace[1722338098] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:624; }","duration":"716.204862ms","start":"2026-04-22T06:00:13.479616Z","end":"2026-04-22T06:00:14.19582Z","steps":["trace[1722338098] 'range keys from in-memory index tree' (duration: 715.418492ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:14.195094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.103719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:00:14.195822Z","caller":"traceutil/trace.go:171","msg":"trace[756574720] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:624; }","duration":"263.016689ms","start":"2026-04-22T06:00:13.932795Z","end":"2026-04-22T06:00:14.195812Z","steps":["trace[756574720] 'range keys from in-memory index tree' (duration: 262.888516ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:14.195865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:13.479596Z","time spent":"716.261522ms","remote":"127.0.0.1:41810","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":"info","ts":"2026-04-22T06:00:14.195925Z","caller":"traceutil/trace.go:171","msg":"trace[1637355764] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:624; }","duration":"232.977259ms","start":"2026-04-22T06:00:13.962887Z","end":"2026-04-22T06:00:14.195864Z","steps":["trace[1637355764] 'range keys from in-memory index tree' (duration: 232.040448ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:14.195932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.426157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:00:14.195962Z","caller":"traceutil/trace.go:171","msg":"trace[1907257850] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:624; }","duration":"630.476188ms","start":"2026-04-22T06:00:13.565477Z","end":"2026-04-22T06:00:14.195953Z","steps":["trace[1907257850] 'range keys from in-memory index tree' (duration: 630.357407ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:14.195999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:13.565467Z","time spent":"630.524189ms","remote":"127.0.0.1:50432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 "} {"level":"warn","ts":"2026-04-22T06:00:14.194941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.797266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:00:14.196046Z","caller":"traceutil/trace.go:171","msg":"trace[1938532115] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:624; }","duration":"263.950309ms","start":"2026-04-22T06:00:13.932087Z","end":"2026-04-22T06:00:14.196037Z","steps":["trace[1938532115] 'range keys from in-memory index tree' (duration: 262.741774ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:00:14.194908Z","caller":"traceutil/trace.go:171","msg":"trace[2112344163] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:624; }","duration":"543.430317ms","start":"2026-04-22T06:00:13.651456Z","end":"2026-04-22T06:00:14.194886Z","steps":["trace[2112344163] 'range keys from in-memory index tree' (duration: 543.257536ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:14.196814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:13.651448Z","time spent":"544.626532ms","remote":"127.0.0.1:50474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-22T06:00:14.195364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.939908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:00:14.197015Z","caller":"traceutil/trace.go:171","msg":"trace[2021378704] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:624; }","duration":"213.595748ms","start":"2026-04-22T06:00:13.983393Z","end":"2026-04-22T06:00:14.196989Z","steps":["trace[2021378704] 'count revisions from in-memory index tree' (duration: 211.842917ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:14.195085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"726.127721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:00:14.197121Z","caller":"traceutil/trace.go:171","msg":"trace[609284429] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:624; }","duration":"728.189844ms","start":"2026-04-22T06:00:13.46891Z","end":"2026-04-22T06:00:14.1971Z","steps":["trace[609284429] 'range keys from in-memory index tree' (duration: 725.985398ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:14.195652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.68036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T06:00:14.197251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:13.468892Z","time spent":"728.300836ms","remote":"127.0.0.1:41594","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-22T06:00:14.197281Z","caller":"traceutil/trace.go:171","msg":"trace[740886118] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:624; }","duration":"632.3319ms","start":"2026-04-22T06:00:13.564932Z","end":"2026-04-22T06:00:14.197264Z","steps":["trace[740886118] 'range keys from in-memory index tree' (duration: 630.551178ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:14.197317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:13.564913Z","time spent":"632.390701ms","remote":"127.0.0.1:50432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 "} {"level":"warn","ts":"2026-04-22T06:00:14.200358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.691601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:00:14.200431Z","caller":"traceutil/trace.go:171","msg":"trace[486167616] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:624; }","duration":"620.765881ms","start":"2026-04-22T06:00:13.579638Z","end":"2026-04-22T06:00:14.200403Z","steps":["trace[486167616] 'range keys from in-memory index tree' (duration: 620.611059ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:14.195327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.093122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T06:00:14.202212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:13.579632Z","time spent":"622.559243ms","remote":"127.0.0.1:50438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"info","ts":"2026-04-22T06:00:14.202436Z","caller":"traceutil/trace.go:171","msg":"trace[885098456] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:624; }","duration":"564.194465ms","start":"2026-04-22T06:00:13.638225Z","end":"2026-04-22T06:00:14.20242Z","steps":["trace[885098456] 'range keys from in-memory index tree' (duration: 557.050831ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:14.20254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:13.6382Z","time spent":"564.266196ms","remote":"127.0.0.1:50454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-22T06:00:14.195292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.428125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:00:14.202877Z","caller":"traceutil/trace.go:171","msg":"trace[133853008] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:624; }","duration":"565.033995ms","start":"2026-04-22T06:00:13.637833Z","end":"2026-04-22T06:00:14.202867Z","steps":["trace[133853008] 'count revisions from in-memory index tree' (duration: 557.341494ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:14.202916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:13.637823Z","time spent":"565.079986ms","remote":"127.0.0.1:50460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-22T06:00:14.203492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"623.328351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:00:14.203552Z","caller":"traceutil/trace.go:171","msg":"trace[906480791] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:624; }","duration":"623.429963ms","start":"2026-04-22T06:00:13.580108Z","end":"2026-04-22T06:00:14.203538Z","steps":["trace[906480791] 'count revisions from in-memory index tree' (duration: 623.269301ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:14.203595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:13.580093Z","time spent":"623.493254ms","remote":"127.0.0.1:50438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-04-22T06:00:14.206429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"624.04197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:00:14.206739Z","caller":"traceutil/trace.go:171","msg":"trace[631295282] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:624; }","duration":"624.391524ms","start":"2026-04-22T06:00:13.582336Z","end":"2026-04-22T06:00:14.206728Z","steps":["trace[631295282] 'range keys from in-memory index tree' (duration: 623.98137ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:14.206957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:13.582329Z","time spent":"624.430494ms","remote":"127.0.0.1:50438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"info","ts":"2026-04-22T06:00:17.166718Z","caller":"traceutil/trace.go:171","msg":"trace[1000663976] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"104.365628ms","start":"2026-04-22T06:00:17.062334Z","end":"2026-04-22T06:00:17.1667Z","steps":["trace[1000663976] 'process raft request' (duration: 104.225547ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:00:17.166712Z","caller":"traceutil/trace.go:171","msg":"trace[493719488] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"109.7272ms","start":"2026-04-22T06:00:17.056952Z","end":"2026-04-22T06:00:17.166679Z","steps":["trace[493719488] 'process raft request' (duration: 109.434647ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:00:23.034094Z","caller":"traceutil/trace.go:171","msg":"trace[1361650983] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"121.954055ms","start":"2026-04-22T06:00:22.912086Z","end":"2026-04-22T06:00:23.03404Z","steps":["trace[1361650983] 'process raft request' (duration: 121.703573ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:52.970763Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656052181030443095,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-22T06:00:53.08891Z","caller":"traceutil/trace.go:171","msg":"trace[1525959770] transaction","detail":"{read_only:false; response_revision:854; number_of_response:1; }","duration":"887.300241ms","start":"2026-04-22T06:00:52.20158Z","end":"2026-04-22T06:00:53.088881Z","steps":["trace[1525959770] 'process raft request' (duration: 887.119409ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:53.08909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:52.201554Z","time spent":"887.439623ms","remote":"127.0.0.1:41752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4025,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:00:53.095729Z","caller":"traceutil/trace.go:171","msg":"trace[1793890044] linearizableReadLoop","detail":"{readStateIndex:889; appliedIndex:887; }","duration":"625.103707ms","start":"2026-04-22T06:00:52.470602Z","end":"2026-04-22T06:00:53.095705Z","steps":["trace[1793890044] 'read index received' (duration: 618.096013ms)","trace[1793890044] 'applied index is now lower than readState.Index' (duration: 7.006104ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:00:53.09587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.255798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:00:53.095901Z","caller":"traceutil/trace.go:171","msg":"trace[2029682072] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:854; }","duration":"625.34397ms","start":"2026-04-22T06:00:52.470547Z","end":"2026-04-22T06:00:53.095891Z","steps":["trace[2029682072] 'agreement among raft nodes before linearized reading' (duration: 625.268799ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:53.095927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:52.470527Z","time spent":"625.39427ms","remote":"127.0.0.1:41594","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-22T06:00:53.096199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.363635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-22T06:00:53.096186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.946171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-22T06:00:53.096184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.520394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-22T06:00:53.096259Z","caller":"traceutil/trace.go:171","msg":"trace[1119288964] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:854; }","duration":"462.496917ms","start":"2026-04-22T06:00:52.633748Z","end":"2026-04-22T06:00:53.096245Z","steps":["trace[1119288964] 'agreement among raft nodes before linearized reading' (duration: 462.216855ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:00:53.096279Z","caller":"traceutil/trace.go:171","msg":"trace[1288894343] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:854; }","duration":"462.075212ms","start":"2026-04-22T06:00:52.634181Z","end":"2026-04-22T06:00:53.096256Z","steps":["trace[1288894343] 'agreement among raft nodes before linearized reading' (duration: 461.78618ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:53.0963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:52.633726Z","time spent":"462.566827ms","remote":"127.0.0.1:41810","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":"info","ts":"2026-04-22T06:00:53.096311Z","caller":"traceutil/trace.go:171","msg":"trace[1776242922] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:854; }","duration":"525.727436ms","start":"2026-04-22T06:00:52.570554Z","end":"2026-04-22T06:00:53.096281Z","steps":["trace[1776242922] 'agreement among raft nodes before linearized reading' (duration: 525.333033ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:53.096394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:52.570536Z","time spent":"525.846947ms","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-22T06:00:53.096417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.720137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-22T06:00:53.096329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:52.634171Z","time spent":"462.149412ms","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-22T06:00:53.096456Z","caller":"traceutil/trace.go:171","msg":"trace[789755994] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:854; }","duration":"464.799327ms","start":"2026-04-22T06:00:52.631641Z","end":"2026-04-22T06:00:53.09644Z","steps":["trace[789755994] 'agreement among raft nodes before linearized reading' (duration: 464.684077ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:00:53.096479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:00:52.631612Z","time spent":"464.862088ms","remote":"127.0.0.1:41810","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-04-22T06:01:07.415331Z","caller":"traceutil/trace.go:171","msg":"trace[778204422] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"104.480055ms","start":"2026-04-22T06:01:07.310824Z","end":"2026-04-22T06:01:07.415304Z","steps":["trace[778204422] 'process raft request' (duration: 104.418043ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:01:07.415409Z","caller":"traceutil/trace.go:171","msg":"trace[1555087287] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"136.909196ms","start":"2026-04-22T06:01:07.278446Z","end":"2026-04-22T06:01:07.415356Z","steps":["trace[1555087287] 'process raft request' (duration: 84.966928ms)","trace[1555087287] 'compare' (duration: 51.6703ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:01:08.068147Z","caller":"traceutil/trace.go:171","msg":"trace[1926314813] transaction","detail":"{read_only:false; response_revision:1024; number_of_response:1; }","duration":"145.994971ms","start":"2026-04-22T06:01:07.922117Z","end":"2026-04-22T06:01:08.068112Z","steps":["trace[1926314813] 'process raft request' (duration: 145.733302ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:01:21.609979Z","caller":"traceutil/trace.go:171","msg":"trace[1356408898] linearizableReadLoop","detail":"{readStateIndex:1288; appliedIndex:1287; }","duration":"278.965267ms","start":"2026-04-22T06:01:21.330991Z","end":"2026-04-22T06:01:21.609957Z","steps":["trace[1356408898] 'read index received' (duration: 278.893255ms)","trace[1356408898] 'applied index is now lower than readState.Index' (duration: 71.032µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:01:21.610094Z","caller":"traceutil/trace.go:171","msg":"trace[631952850] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"370.89715ms","start":"2026-04-22T06:01:21.239175Z","end":"2026-04-22T06:01:21.610072Z","steps":["trace[631952850] 'process raft request' (duration: 370.628452ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:01:21.610335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:01:21.239143Z","time spent":"371.096256ms","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T06:01:21.610349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.303737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-22T06:01:21.610477Z","caller":"traceutil/trace.go:171","msg":"trace[1260743400] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1247; }","duration":"279.503723ms","start":"2026-04-22T06:01:21.330946Z","end":"2026-04-22T06:01:21.61045Z","steps":["trace[1260743400] 'agreement among raft nodes before linearized reading' (duration: 279.180364ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:01:21.623825Z","caller":"traceutil/trace.go:171","msg":"trace[1519300730] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"158.090023ms","start":"2026-04-22T06:01:21.465699Z","end":"2026-04-22T06:01:21.623789Z","steps":["trace[1519300730] 'process raft request' (duration: 155.914981ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:01:21.624012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.611965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-22T06:01:21.624024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.117525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-22T06:01:21.624081Z","caller":"traceutil/trace.go:171","msg":"trace[1905751186] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1250; }","duration":"290.216988ms","start":"2026-04-22T06:01:21.333854Z","end":"2026-04-22T06:01:21.624071Z","steps":["trace[1905751186] 'agreement among raft nodes before linearized reading' (duration: 290.002122ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:01:21.624086Z","caller":"traceutil/trace.go:171","msg":"trace[903055137] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1250; }","duration":"292.690899ms","start":"2026-04-22T06:01:21.331369Z","end":"2026-04-22T06:01:21.62406Z","steps":["trace[903055137] 'agreement among raft nodes before linearized reading' (duration: 292.461252ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:01:38.440765Z","caller":"traceutil/trace.go:171","msg":"trace[1064930082] transaction","detail":"{read_only:false; response_revision:1391; number_of_response:1; }","duration":"108.733117ms","start":"2026-04-22T06:01:38.331999Z","end":"2026-04-22T06:01:38.440732Z","steps":["trace[1064930082] 'process raft request' (duration: 108.541193ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:01:44.661524Z","caller":"traceutil/trace.go:171","msg":"trace[453762765] transaction","detail":"{read_only:false; response_revision:1511; number_of_response:1; }","duration":"194.983995ms","start":"2026-04-22T06:01:44.466522Z","end":"2026-04-22T06:01:44.661506Z","steps":["trace[453762765] 'process raft request' (duration: 194.873732ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:02:08.037067Z","caller":"traceutil/trace.go:171","msg":"trace[1682817448] transaction","detail":"{read_only:false; response_revision:1908; number_of_response:1; }","duration":"486.711492ms","start":"2026-04-22T06:02:07.550331Z","end":"2026-04-22T06:02:08.037043Z","steps":["trace[1682817448] 'process raft request' (duration: 486.546219ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:02:08.037252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:02:07.550311Z","time spent":"486.839834ms","remote":"127.0.0.1:41752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10932,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:02:08.337625Z","caller":"traceutil/trace.go:171","msg":"trace[1935545607] transaction","detail":"{read_only:false; response_revision:1909; number_of_response:1; }","duration":"645.895394ms","start":"2026-04-22T06:02:07.691711Z","end":"2026-04-22T06:02:08.337606Z","steps":["trace[1935545607] 'process raft request' (duration: 645.723921ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:02:08.337754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:02:07.691687Z","time spent":"645.997197ms","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:02:08.337809Z","caller":"traceutil/trace.go:171","msg":"trace[76178420] linearizableReadLoop","detail":"{readStateIndex:1987; appliedIndex:1985; }","duration":"585.489418ms","start":"2026-04-22T06:02:07.752287Z","end":"2026-04-22T06:02:08.337777Z","steps":["trace[76178420] 'read index received' (duration: 284.575043ms)","trace[76178420] 'applied index is now lower than readState.Index' (duration: 300.912665ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:02:08.337929Z","caller":"traceutil/trace.go:171","msg":"trace[548346928] transaction","detail":"{read_only:false; response_revision:1910; number_of_response:1; }","duration":"545.920687ms","start":"2026-04-22T06:02:07.791996Z","end":"2026-04-22T06:02:08.337917Z","steps":["trace[548346928] 'process raft request' (duration: 545.5791ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:02:08.338036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.746723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-733ff5ca-3c0a-4284-b0eb-8a8b47bf1e69\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-04-22T06:02:08.338096Z","caller":"traceutil/trace.go:171","msg":"trace[1078671938] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-733ff5ca-3c0a-4284-b0eb-8a8b47bf1e69; range_end:; response_count:1; response_revision:1910; }","duration":"585.840325ms","start":"2026-04-22T06:02:07.752247Z","end":"2026-04-22T06:02:08.338087Z","steps":["trace[1078671938] 'agreement among raft nodes before linearized reading' (duration: 585.697172ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:02:08.338083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:02:07.791978Z","time spent":"545.985048ms","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T06:02:08.338125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:02:07.75223Z","time spent":"585.888516ms","remote":"127.0.0.1:41752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3770,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-733ff5ca-3c0a-4284-b0eb-8a8b47bf1e69\" "} {"level":"info","ts":"2026-04-22T06:02:08.406374Z","caller":"traceutil/trace.go:171","msg":"trace[1354928306] transaction","detail":"{read_only:false; response_revision:1911; number_of_response:1; }","duration":"363.092378ms","start":"2026-04-22T06:02:08.043214Z","end":"2026-04-22T06:02:08.406306Z","steps":["trace[1354928306] 'process raft request' (duration: 362.908545ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:02:08.406554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:02:08.04319Z","time spent":"363.268883ms","remote":"127.0.0.1:41740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":978,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:02:08.406627Z","caller":"traceutil/trace.go:171","msg":"trace[367877890] transaction","detail":"{read_only:false; response_revision:1912; number_of_response:1; }","duration":"363.13576ms","start":"2026-04-22T06:02:08.043463Z","end":"2026-04-22T06:02:08.406598Z","steps":["trace[367877890] 'process raft request' (duration: 362.804114ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:02:08.406795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:02:08.043442Z","time spent":"363.268342ms","remote":"127.0.0.1:41740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":894,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T06:02:08.407908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"637.226568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-04-22T06:02:08.408012Z","caller":"traceutil/trace.go:171","msg":"trace[220979593] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1914; }","duration":"637.360921ms","start":"2026-04-22T06:02:07.770628Z","end":"2026-04-22T06:02:08.407989Z","steps":["trace[220979593] 'agreement among raft nodes before linearized reading' (duration: 637.082174ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:02:08.408075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:02:07.770615Z","time spent":"637.444462ms","remote":"127.0.0.1:43000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5467,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-04-22T06:02:08.408228Z","caller":"traceutil/trace.go:171","msg":"trace[1516121587] transaction","detail":"{read_only:false; response_revision:1913; number_of_response:1; }","duration":"364.310912ms","start":"2026-04-22T06:02:08.043898Z","end":"2026-04-22T06:02:08.408209Z","steps":["trace[1516121587] 'process raft request' (duration: 363.562758ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:02:08.408358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:02:08.04389Z","time spent":"364.395274ms","remote":"127.0.0.1:41820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1530,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T06:02:08.408397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.997802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-22T06:02:08.408444Z","caller":"traceutil/trace.go:171","msg":"trace[1280026743] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1914; }","duration":"499.084963ms","start":"2026-04-22T06:02:07.909345Z","end":"2026-04-22T06:02:08.40843Z","steps":["trace[1280026743] 'agreement among raft nodes before linearized reading' (duration: 498.950231ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:02:08.408495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:02:07.909294Z","time spent":"499.189686ms","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-22T06:02:08.408511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"611.510297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-22T06:02:08.408592Z","caller":"traceutil/trace.go:171","msg":"trace[1234892705] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1914; }","duration":"611.607578ms","start":"2026-04-22T06:02:07.796941Z","end":"2026-04-22T06:02:08.408548Z","steps":["trace[1234892705] 'agreement among raft nodes before linearized reading' (duration: 611.369442ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:02:08.408015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.242061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-22T06:02:08.408747Z","caller":"traceutil/trace.go:171","msg":"trace[1579656491] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1914; }","duration":"495.974325ms","start":"2026-04-22T06:02:07.912756Z","end":"2026-04-22T06:02:08.40873Z","steps":["trace[1579656491] 'agreement among raft nodes before linearized reading' (duration: 495.152549ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:02:08.408818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:02:07.912692Z","time spent":"496.111137ms","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-22T06:02:08.408667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:02:07.796919Z","time spent":"611.71253ms","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-04-22T06:02:08.40918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.27398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-22T06:02:08.40922Z","caller":"traceutil/trace.go:171","msg":"trace[125938263] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1914; }","duration":"595.353041ms","start":"2026-04-22T06:02:07.813855Z","end":"2026-04-22T06:02:08.409208Z","steps":["trace[125938263] 'agreement among raft nodes before linearized reading' (duration: 595.243568ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:02:08.409254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:02:07.813834Z","time spent":"595.409562ms","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-22T06:02:08.409232Z","caller":"traceutil/trace.go:171","msg":"trace[1603374357] transaction","detail":"{read_only:false; response_revision:1914; number_of_response:1; }","duration":"364.13771ms","start":"2026-04-22T06:02:08.044151Z","end":"2026-04-22T06:02:08.408289Z","steps":["trace[1603374357] 'process raft request' (duration: 363.487237ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:02:08.409291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.729116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-22T06:02:08.409345Z","caller":"traceutil/trace.go:171","msg":"trace[2004414313] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1914; }","duration":"541.812128ms","start":"2026-04-22T06:02:07.867518Z","end":"2026-04-22T06:02:08.40933Z","steps":["trace[2004414313] 'agreement among raft nodes before linearized reading' (duration: 541.211786ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:02:08.409387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:02:07.8675Z","time spent":"541.876828ms","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-22T06:02:08.40962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:02:08.04414Z","time spent":"365.184011ms","remote":"127.0.0.1:41820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1472,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:02:20.650438Z","caller":"traceutil/trace.go:171","msg":"trace[1578498321] linearizableReadLoop","detail":"{readStateIndex:2098; appliedIndex:2097; }","duration":"161.400396ms","start":"2026-04-22T06:02:20.489008Z","end":"2026-04-22T06:02:20.650408Z","steps":["trace[1578498321] 'read index received' (duration: 155.742825ms)","trace[1578498321] 'applied index is now lower than readState.Index' (duration: 5.656271ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:02:20.650549Z","caller":"traceutil/trace.go:171","msg":"trace[2097103350] transaction","detail":"{read_only:false; response_revision:2018; number_of_response:1; }","duration":"176.313723ms","start":"2026-04-22T06:02:20.474205Z","end":"2026-04-22T06:02:20.650519Z","steps":["trace[2097103350] 'process raft request' (duration: 170.616191ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:02:20.650819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.297654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-22T06:02:20.650922Z","caller":"traceutil/trace.go:171","msg":"trace[765714311] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2018; }","duration":"136.429977ms","start":"2026-04-22T06:02:20.514472Z","end":"2026-04-22T06:02:20.650902Z","steps":["trace[765714311] 'agreement among raft nodes before linearized reading' (duration: 136.133951ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:02:20.650856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.817723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"warn","ts":"2026-04-22T06:02:20.651061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.659514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-22T06:02:20.65111Z","caller":"traceutil/trace.go:171","msg":"trace[804542438] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2018; }","duration":"110.764846ms","start":"2026-04-22T06:02:20.540331Z","end":"2026-04-22T06:02:20.651096Z","steps":["trace[804542438] 'agreement among raft nodes before linearized reading' (duration: 110.586093ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:02:20.65107Z","caller":"traceutil/trace.go:171","msg":"trace[1894886134] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2018; }","duration":"162.068308ms","start":"2026-04-22T06:02:20.488945Z","end":"2026-04-22T06:02:20.651013Z","steps":["trace[1894886134] 'agreement among raft nodes before linearized reading' (duration: 161.61367ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:02:20.651176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.585133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-22T06:02:20.651216Z","caller":"traceutil/trace.go:171","msg":"trace[1878899889] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2018; }","duration":"110.667735ms","start":"2026-04-22T06:02:20.540538Z","end":"2026-04-22T06:02:20.651206Z","steps":["trace[1878899889] 'agreement among raft nodes before linearized reading' (duration: 110.514633ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:02:20.651302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.677133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-22T06:02:20.651432Z","caller":"traceutil/trace.go:171","msg":"trace[1097731686] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2018; }","duration":"121.859226ms","start":"2026-04-22T06:02:20.529548Z","end":"2026-04-22T06:02:20.651407Z","steps":["trace[1097731686] 'agreement among raft nodes before linearized reading' (duration: 121.435869ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:02:56.989517Z","caller":"traceutil/trace.go:171","msg":"trace[595686366] transaction","detail":"{read_only:false; response_revision:2225; number_of_response:1; }","duration":"105.304227ms","start":"2026-04-22T06:02:56.884187Z","end":"2026-04-22T06:02:56.989492Z","steps":["trace[595686366] 'process raft request' (duration: 105.146315ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:02:57.001918Z","caller":"traceutil/trace.go:171","msg":"trace[351457546] linearizableReadLoop","detail":"{readStateIndex:2314; appliedIndex:2312; }","duration":"116.929351ms","start":"2026-04-22T06:02:56.88497Z","end":"2026-04-22T06:02:57.001899Z","steps":["trace[351457546] 'read index received' (duration: 104.431854ms)","trace[351457546] 'applied index is now lower than readState.Index' (duration: 12.496757ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:02:57.002016Z","caller":"traceutil/trace.go:171","msg":"trace[1305856753] transaction","detail":"{read_only:false; response_revision:2226; number_of_response:1; }","duration":"117.723823ms","start":"2026-04-22T06:02:56.884266Z","end":"2026-04-22T06:02:57.00199Z","steps":["trace[1305856753] 'process raft request' (duration: 117.531401ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:02:57.00224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.945811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-22T06:02:57.002335Z","caller":"traceutil/trace.go:171","msg":"trace[2032880018] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2226; }","duration":"117.056974ms","start":"2026-04-22T06:02:56.885246Z","end":"2026-04-22T06:02:57.002303Z","steps":["trace[2032880018] 'agreement among raft nodes before linearized reading' (duration: 116.80472ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:02:57.002502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.52421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-22T06:02:57.00256Z","caller":"traceutil/trace.go:171","msg":"trace[1248504677] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2226; }","duration":"117.621812ms","start":"2026-04-22T06:02:56.884929Z","end":"2026-04-22T06:02:57.002551Z","steps":["trace[1248504677] 'agreement among raft nodes before linearized reading' (duration: 117.070893ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:02:57.003257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.783604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-22T06:02:57.003988Z","caller":"traceutil/trace.go:171","msg":"trace[985727267] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2226; }","duration":"118.658358ms","start":"2026-04-22T06:02:56.885308Z","end":"2026-04-22T06:02:57.003966Z","steps":["trace[985727267] 'agreement among raft nodes before linearized reading' (duration: 116.862001ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:02:57.512317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.069524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.227\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-22T06:02:57.512401Z","caller":"traceutil/trace.go:171","msg":"trace[574876309] range","detail":"{range_begin:/registry/masterleases/199.204.45.227; range_end:; response_count:1; response_revision:2229; }","duration":"255.187815ms","start":"2026-04-22T06:02:57.257195Z","end":"2026-04-22T06:02:57.512382Z","steps":["trace[574876309] 'range keys from in-memory index tree' (duration: 254.849021ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:02:57.5124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.337005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:02:57.512471Z","caller":"traceutil/trace.go:171","msg":"trace[307338911] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:2229; }","duration":"232.463217ms","start":"2026-04-22T06:02:57.27999Z","end":"2026-04-22T06:02:57.512453Z","steps":["trace[307338911] 'count revisions from in-memory index tree' (duration: 232.202474ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:02:57.512485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.863676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-22T06:02:57.512552Z","caller":"traceutil/trace.go:171","msg":"trace[2069336070] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2229; }","duration":"371.977987ms","start":"2026-04-22T06:02:57.140557Z","end":"2026-04-22T06:02:57.512534Z","steps":["trace[2069336070] 'range keys from in-memory index tree' (duration: 371.672514ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:02:57.512594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:02:57.140533Z","time spent":"372.052709ms","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-22T06:02:57.512817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.490592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:02:57.513054Z","caller":"traceutil/trace.go:171","msg":"trace[1855883799] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:2229; }","duration":"302.736395ms","start":"2026-04-22T06:02:57.210304Z","end":"2026-04-22T06:02:57.51304Z","steps":["trace[1855883799] 'count revisions from in-memory index tree' (duration: 302.425281ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:02:57.513096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:02:57.210263Z","time spent":"302.820806ms","remote":"127.0.0.1:50550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-22T06:02:57.744666Z","caller":"traceutil/trace.go:171","msg":"trace[678474774] transaction","detail":"{read_only:false; response_revision:2230; number_of_response:1; }","duration":"359.936749ms","start":"2026-04-22T06:02:57.384702Z","end":"2026-04-22T06:02:57.744639Z","steps":["trace[678474774] 'process raft request' (duration: 359.807097ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:02:57.744852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:02:57.384677Z","time spent":"360.07787ms","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:02:57.745188Z","caller":"traceutil/trace.go:171","msg":"trace[839385892] linearizableReadLoop","detail":"{readStateIndex:2318; appliedIndex:2318; }","duration":"274.419583ms","start":"2026-04-22T06:02:57.470757Z","end":"2026-04-22T06:02:57.745176Z","steps":["trace[839385892] 'read index received' (duration: 274.413903ms)","trace[839385892] 'applied index is now lower than readState.Index' (duration: 4.48µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:02:57.745276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.538184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:02:57.74531Z","caller":"traceutil/trace.go:171","msg":"trace[142649293] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2230; }","duration":"274.620646ms","start":"2026-04-22T06:02:57.47068Z","end":"2026-04-22T06:02:57.745301Z","steps":["trace[142649293] 'agreement among raft nodes before linearized reading' (duration: 274.561045ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:02:57.77766Z","caller":"traceutil/trace.go:171","msg":"trace[384295934] transaction","detail":"{read_only:false; response_revision:2231; number_of_response:1; }","duration":"260.477255ms","start":"2026-04-22T06:02:57.517167Z","end":"2026-04-22T06:02:57.777645Z","steps":["trace[384295934] 'process raft request' (duration: 260.365254ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:02:57.777835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.501502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-22T06:02:57.777898Z","caller":"traceutil/trace.go:171","msg":"trace[446832108] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:2231; }","duration":"178.595993ms","start":"2026-04-22T06:02:57.59929Z","end":"2026-04-22T06:02:57.777886Z","steps":["trace[446832108] 'agreement among raft nodes before linearized reading' (duration: 178.493702ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:02:58.003903Z","caller":"traceutil/trace.go:171","msg":"trace[1853914137] transaction","detail":"{read_only:false; response_revision:2232; number_of_response:1; }","duration":"224.741392ms","start":"2026-04-22T06:02:57.779131Z","end":"2026-04-22T06:02:58.003873Z","steps":["trace[1853914137] 'process raft request' (duration: 194.624673ms)","trace[1853914137] 'compare' (duration: 29.860466ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:03:38.794357Z","caller":"traceutil/trace.go:171","msg":"trace[1966074823] transaction","detail":"{read_only:false; response_revision:2558; number_of_response:1; }","duration":"133.437177ms","start":"2026-04-22T06:03:38.660886Z","end":"2026-04-22T06:03:38.794323Z","steps":["trace[1966074823] 'process raft request' (duration: 133.122403ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:03:38.794382Z","caller":"traceutil/trace.go:171","msg":"trace[1125140372] transaction","detail":"{read_only:false; response_revision:2559; number_of_response:1; }","duration":"133.448227ms","start":"2026-04-22T06:03:38.6609Z","end":"2026-04-22T06:03:38.794349Z","steps":["trace[1125140372] 'process raft request' (duration: 133.305525ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:04:05.705179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.748326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:04:05.705322Z","caller":"traceutil/trace.go:171","msg":"trace[273170880] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:2711; }","duration":"132.920899ms","start":"2026-04-22T06:04:05.572345Z","end":"2026-04-22T06:04:05.705265Z","steps":["trace[273170880] 'count revisions from in-memory index tree' (duration: 132.660926ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:04:05.705512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.967072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-22T06:04:05.705647Z","caller":"traceutil/trace.go:171","msg":"trace[1577238202] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2711; }","duration":"146.147993ms","start":"2026-04-22T06:04:05.559475Z","end":"2026-04-22T06:04:05.705623Z","steps":["trace[1577238202] 'range keys from in-memory index tree' (duration: 145.661387ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:04:11.230993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.720604ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T06:04:11.231126Z","caller":"traceutil/trace.go:171","msg":"trace[136944221] transaction","detail":"{read_only:false; response_revision:2735; number_of_response:1; }","duration":"315.171294ms","start":"2026-04-22T06:04:10.915932Z","end":"2026-04-22T06:04:11.231103Z","steps":["trace[136944221] 'process raft request' (duration: 127.996714ms)","trace[136944221] 'compare' (duration: 186.456362ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:04:11.231472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:04:10.915898Z","time spent":"315.264885ms","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T06:04:11.809004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.959842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-22T06:04:11.809121Z","caller":"traceutil/trace.go:171","msg":"trace[1574371125] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2735; }","duration":"351.139444ms","start":"2026-04-22T06:04:11.457955Z","end":"2026-04-22T06:04:11.809094Z","steps":["trace[1574371125] 'range keys from in-memory index tree' (duration: 350.631638ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:04:11.809174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:04:11.45793Z","time spent":"351.233925ms","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-22T06:04:11.809151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.688264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-22T06:04:11.809248Z","caller":"traceutil/trace.go:171","msg":"trace[739557978] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2735; }","duration":"348.859057ms","start":"2026-04-22T06:04:11.460367Z","end":"2026-04-22T06:04:11.809226Z","steps":["trace[739557978] 'range keys from in-memory index tree' (duration: 348.466642ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:04:11.809296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:04:11.460339Z","time spent":"348.947968ms","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-22T06:04:11.80956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.937044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-22T06:04:11.809603Z","caller":"traceutil/trace.go:171","msg":"trace[376223471] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2735; }","duration":"339.012744ms","start":"2026-04-22T06:04:11.470575Z","end":"2026-04-22T06:04:11.809588Z","steps":["trace[376223471] 'range keys from in-memory index tree' (duration: 338.817512ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:04:11.809634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:04:11.470557Z","time spent":"339.069386ms","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-22T06:04:11.80977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.701131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18a898980142f937\" ","response":"range_response_count:1 size:777"} {"level":"info","ts":"2026-04-22T06:04:11.809808Z","caller":"traceutil/trace.go:171","msg":"trace[29724982] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18a898980142f937; range_end:; response_count:1; response_revision:2735; }","duration":"185.806323ms","start":"2026-04-22T06:04:11.62399Z","end":"2026-04-22T06:04:11.809797Z","steps":["trace[29724982] 'range keys from in-memory index tree' (duration: 185.54634ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:04:11.809924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.448639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-22T06:04:11.809974Z","caller":"traceutil/trace.go:171","msg":"trace[1527215936] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2735; }","duration":"338.564361ms","start":"2026-04-22T06:04:11.471396Z","end":"2026-04-22T06:04:11.80996Z","steps":["trace[1527215936] 'range keys from in-memory index tree' (duration: 338.317616ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:04:11.810036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:04:11.471384Z","time spent":"338.641871ms","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-22T06:04:11.810466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.190236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-22T06:04:11.810514Z","caller":"traceutil/trace.go:171","msg":"trace[79438828] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2735; }","duration":"334.253986ms","start":"2026-04-22T06:04:11.476239Z","end":"2026-04-22T06:04:11.810493Z","steps":["trace[79438828] 'range keys from in-memory index tree' (duration: 334.047984ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:04:11.810551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:04:11.476227Z","time spent":"334.314387ms","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-04-22T06:04:11.810832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.548777ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T06:04:11.810909Z","caller":"traceutil/trace.go:171","msg":"trace[361507474] transaction","detail":"{read_only:false; response_revision:2736; number_of_response:1; }","duration":"160.407221ms","start":"2026-04-22T06:04:11.650486Z","end":"2026-04-22T06:04:11.810894Z","steps":["trace[361507474] 'process raft request' (duration: 19.715532ms)","trace[361507474] 'compare' (duration: 139.940599ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:05:17.411669Z","caller":"traceutil/trace.go:171","msg":"trace[694879034] transaction","detail":"{read_only:false; response_revision:3087; number_of_response:1; }","duration":"139.324253ms","start":"2026-04-22T06:05:17.272314Z","end":"2026-04-22T06:05:17.411639Z","steps":["trace[694879034] 'process raft request' (duration: 67.136235ms)","trace[694879034] 'compare' (duration: 71.99417ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:05:40.458096Z","caller":"traceutil/trace.go:171","msg":"trace[119537952] transaction","detail":"{read_only:false; response_revision:3203; number_of_response:1; }","duration":"104.626017ms","start":"2026-04-22T06:05:40.3533Z","end":"2026-04-22T06:05:40.457926Z","steps":["trace[119537952] 'process raft request' (duration: 64.975179ms)","trace[119537952] 'compare' (duration: 39.330566ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:05:40.45822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.744568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-04-22T06:05:40.458304Z","caller":"traceutil/trace.go:171","msg":"trace[1113524666] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:3204; }","duration":"119.877353ms","start":"2026-04-22T06:05:40.338408Z","end":"2026-04-22T06:05:40.458285Z","steps":["trace[1113524666] 'agreement among raft nodes before linearized reading' (duration: 119.625752ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:05:40.458388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.733078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-22T06:05:40.458469Z","caller":"traceutil/trace.go:171","msg":"trace[1358260941] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3204; }","duration":"120.831811ms","start":"2026-04-22T06:05:40.337617Z","end":"2026-04-22T06:05:40.458449Z","steps":["trace[1358260941] 'agreement among raft nodes before linearized reading' (duration: 120.650864ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:05:40.458639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.466027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-22T06:05:40.458706Z","caller":"traceutil/trace.go:171","msg":"trace[1206704106] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:3204; }","duration":"120.5566ms","start":"2026-04-22T06:05:40.338132Z","end":"2026-04-22T06:05:40.458689Z","steps":["trace[1206704106] 'agreement among raft nodes before linearized reading' (duration: 120.388124ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:05:40.576129Z","caller":"traceutil/trace.go:171","msg":"trace[1073370577] linearizableReadLoop","detail":"{readStateIndex:3331; appliedIndex:3328; }","duration":"111.436444ms","start":"2026-04-22T06:05:40.464654Z","end":"2026-04-22T06:05:40.57609Z","steps":["trace[1073370577] 'read index received' (duration: 41.587014ms)","trace[1073370577] 'applied index is now lower than readState.Index' (duration: 69.84785ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:05:40.576277Z","caller":"traceutil/trace.go:171","msg":"trace[1783005817] transaction","detail":"{read_only:false; response_revision:3207; number_of_response:1; }","duration":"113.169131ms","start":"2026-04-22T06:05:40.463097Z","end":"2026-04-22T06:05:40.576266Z","steps":["trace[1783005817] 'process raft request' (duration: 112.924392ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:05:40.576177Z","caller":"traceutil/trace.go:171","msg":"trace[2087882736] transaction","detail":"{read_only:false; response_revision:3206; number_of_response:1; }","duration":"113.165632ms","start":"2026-04-22T06:05:40.462973Z","end":"2026-04-22T06:05:40.576139Z","steps":["trace[2087882736] 'process raft request' (duration: 107.998511ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:05:40.576507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.159127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:05:40.576556Z","caller":"traceutil/trace.go:171","msg":"trace[1801711591] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3207; }","duration":"107.21149ms","start":"2026-04-22T06:05:40.469328Z","end":"2026-04-22T06:05:40.576539Z","steps":["trace[1801711591] 'agreement among raft nodes before linearized reading' (duration: 107.161298ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:05:40.576422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.746755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak\" ","response":"range_response_count:1 size:1319"} {"level":"info","ts":"2026-04-22T06:05:40.576701Z","caller":"traceutil/trace.go:171","msg":"trace[842262587] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak; range_end:; response_count:1; response_revision:3207; }","duration":"112.059548ms","start":"2026-04-22T06:05:40.464628Z","end":"2026-04-22T06:05:40.576687Z","steps":["trace[842262587] 'agreement among raft nodes before linearized reading' (duration: 111.649432ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:07:06.687056Z","caller":"traceutil/trace.go:171","msg":"trace[2140800088] transaction","detail":"{read_only:false; response_revision:3807; number_of_response:1; }","duration":"158.355049ms","start":"2026-04-22T06:07:06.528673Z","end":"2026-04-22T06:07:06.687028Z","steps":["trace[2140800088] 'process raft request' (duration: 115.735952ms)","trace[2140800088] 'compare' (duration: 42.458062ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:07:06.689855Z","caller":"traceutil/trace.go:171","msg":"trace[1928769174] transaction","detail":"{read_only:false; response_revision:3809; number_of_response:1; }","duration":"104.005263ms","start":"2026-04-22T06:07:06.585822Z","end":"2026-04-22T06:07:06.689827Z","steps":["trace[1928769174] 'process raft request' (duration: 103.804727ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:07:06.690324Z","caller":"traceutil/trace.go:171","msg":"trace[1375620068] transaction","detail":"{read_only:false; response_revision:3808; number_of_response:1; }","duration":"142.696044ms","start":"2026-04-22T06:07:06.547567Z","end":"2026-04-22T06:07:06.690263Z","steps":["trace[1375620068] 'process raft request' (duration: 141.667195ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:07:21.599865Z","caller":"traceutil/trace.go:171","msg":"trace[1608468026] transaction","detail":"{read_only:false; response_revision:3909; number_of_response:1; }","duration":"102.507191ms","start":"2026-04-22T06:07:21.497335Z","end":"2026-04-22T06:07:21.599842Z","steps":["trace[1608468026] 'process raft request' (duration: 102.371858ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:07:53.131026Z","caller":"traceutil/trace.go:171","msg":"trace[1744179337] transaction","detail":"{read_only:false; response_revision:4484; number_of_response:1; }","duration":"114.4429ms","start":"2026-04-22T06:07:53.016554Z","end":"2026-04-22T06:07:53.130997Z","steps":["trace[1744179337] 'process raft request' (duration: 114.195595ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:07:53.131272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.207977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-04-22T06:07:53.131339Z","caller":"traceutil/trace.go:171","msg":"trace[1719801063] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:4484; }","duration":"103.34808ms","start":"2026-04-22T06:07:53.027979Z","end":"2026-04-22T06:07:53.131327Z","steps":["trace[1719801063] 'agreement among raft nodes before linearized reading' (duration: 103.090615ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:07:53.131014Z","caller":"traceutil/trace.go:171","msg":"trace[2122115075] linearizableReadLoop","detail":"{readStateIndex:4657; appliedIndex:4656; }","duration":"102.928221ms","start":"2026-04-22T06:07:53.028029Z","end":"2026-04-22T06:07:53.130958Z","steps":["trace[2122115075] 'read index received' (duration: 102.509191ms)","trace[2122115075] 'applied index is now lower than readState.Index' (duration: 418.15µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:08:03.049119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.410388ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-22T06:08:03.049222Z","caller":"traceutil/trace.go:171","msg":"trace[1522351134] linearizableReadLoop","detail":"{readStateIndex:4867; appliedIndex:4866; }","duration":"578.870003ms","start":"2026-04-22T06:08:02.470335Z","end":"2026-04-22T06:08:03.049205Z","steps":["trace[1522351134] 'read index received' (duration: 206.302212ms)","trace[1522351134] 'applied index is now lower than readState.Index' (duration: 372.566521ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:08:03.049505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.14664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-85a01610-d5ce-46c9-981d-974fd0d9e6cc\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-04-22T06:08:03.049586Z","caller":"traceutil/trace.go:171","msg":"trace[357717229] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-85a01610-d5ce-46c9-981d-974fd0d9e6cc; range_end:; response_count:1; response_revision:4689; }","duration":"579.286703ms","start":"2026-04-22T06:08:02.470282Z","end":"2026-04-22T06:08:03.049569Z","steps":["trace[357717229] 'agreement among raft nodes before linearized reading' (duration: 578.972216ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:03.049628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:02.470261Z","time spent":"579.357745ms","remote":"127.0.0.1:41752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3669,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-85a01610-d5ce-46c9-981d-974fd0d9e6cc\" "} {"level":"info","ts":"2026-04-22T06:08:03.490568Z","caller":"traceutil/trace.go:171","msg":"trace[1298620533] transaction","detail":"{read_only:false; response_revision:4694; number_of_response:1; }","duration":"146.84302ms","start":"2026-04-22T06:08:03.343698Z","end":"2026-04-22T06:08:03.490541Z","steps":["trace[1298620533] 'process raft request' (duration: 146.614945ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:12.123767Z","caller":"traceutil/trace.go:171","msg":"trace[519275011] transaction","detail":"{read_only:false; response_revision:4860; number_of_response:1; }","duration":"105.852424ms","start":"2026-04-22T06:08:12.017891Z","end":"2026-04-22T06:08:12.123743Z","steps":["trace[519275011] 'process raft request' (duration: 105.68325ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:15.91622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.813823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-22T06:08:15.916271Z","caller":"traceutil/trace.go:171","msg":"trace[1839227613] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4877; }","duration":"444.974417ms","start":"2026-04-22T06:08:15.471285Z","end":"2026-04-22T06:08:15.916259Z","steps":["trace[1839227613] 'range keys from in-memory index tree' (duration: 444.67368ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:15.916294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:15.471261Z","time spent":"445.027778ms","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-22T06:08:15.916482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.325969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10392"} {"level":"info","ts":"2026-04-22T06:08:15.916501Z","caller":"traceutil/trace.go:171","msg":"trace[402461022] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4877; }","duration":"559.37585ms","start":"2026-04-22T06:08:15.35712Z","end":"2026-04-22T06:08:15.916496Z","steps":["trace[402461022] 'range keys from in-memory index tree' (duration: 559.235377ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:15.916512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:15.357098Z","time spent":"559.411701ms","remote":"127.0.0.1:41752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":10415,"request content":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-04-22T06:08:15.916538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.561709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-04-22T06:08:15.916583Z","caller":"traceutil/trace.go:171","msg":"trace[1743624819] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4877; }","duration":"369.641532ms","start":"2026-04-22T06:08:15.546929Z","end":"2026-04-22T06:08:15.91657Z","steps":["trace[1743624819] 'range keys from in-memory index tree' (duration: 369.444786ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:15.916603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.546984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-04-22T06:08:15.916617Z","caller":"traceutil/trace.go:171","msg":"trace[1619743162] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4877; }","duration":"529.598256ms","start":"2026-04-22T06:08:15.387014Z","end":"2026-04-22T06:08:15.916612Z","steps":["trace[1619743162] 'range keys from in-memory index tree' (duration: 529.446302ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:15.916617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:15.54691Z","time spent":"369.696873ms","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-04-22T06:08:15.91663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:15.386992Z","time spent":"529.634337ms","remote":"127.0.0.1:41730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-04-22T06:08:15.916849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.70252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-22T06:08:15.916877Z","caller":"traceutil/trace.go:171","msg":"trace[972862590] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4877; }","duration":"322.757142ms","start":"2026-04-22T06:08:15.594111Z","end":"2026-04-22T06:08:15.916868Z","steps":["trace[972862590] 'range keys from in-memory index tree' (duration: 322.610228ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:15.916905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:15.594096Z","time spent":"322.803392ms","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-22T06:08:15.917016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.106424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-04-22T06:08:15.917064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.704229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-22T06:08:15.917082Z","caller":"traceutil/trace.go:171","msg":"trace[200617316] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4877; }","duration":"316.758139ms","start":"2026-04-22T06:08:15.600319Z","end":"2026-04-22T06:08:15.917078Z","steps":["trace[200617316] 'range keys from in-memory index tree' (duration: 316.613886ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:15.917096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:15.6003Z","time spent":"316.79245ms","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-22T06:08:15.917087Z","caller":"traceutil/trace.go:171","msg":"trace[1972498303] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4877; }","duration":"513.224326ms","start":"2026-04-22T06:08:15.403844Z","end":"2026-04-22T06:08:15.917069Z","steps":["trace[1972498303] 'range keys from in-memory index tree' (duration: 512.91389ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:15.917131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:15.403826Z","time spent":"513.296928ms","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-22T06:08:15.917175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.259657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-22T06:08:15.917189Z","caller":"traceutil/trace.go:171","msg":"trace[1898074867] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4877; }","duration":"315.289887ms","start":"2026-04-22T06:08:15.601895Z","end":"2026-04-22T06:08:15.917185Z","steps":["trace[1898074867] 'range keys from in-memory index tree' (duration: 315.207755ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:15.917201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:08:15.601888Z","time spent":"315.310107ms","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-22T06:08:15.917326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.917562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T06:08:15.917338Z","caller":"traceutil/trace.go:171","msg":"trace[139276078] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4877; }","duration":"229.963413ms","start":"2026-04-22T06:08:15.68737Z","end":"2026-04-22T06:08:15.917334Z","steps":["trace[139276078] 'range keys from in-memory index tree' (duration: 229.845341ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:16.046885Z","caller":"traceutil/trace.go:171","msg":"trace[87924785] transaction","detail":"{read_only:false; response_revision:4882; number_of_response:1; }","duration":"124.956683ms","start":"2026-04-22T06:08:15.921905Z","end":"2026-04-22T06:08:16.046861Z","steps":["trace[87924785] 'process raft request' (duration: 124.885001ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:16.046978Z","caller":"traceutil/trace.go:171","msg":"trace[1379220518] transaction","detail":"{read_only:false; response_revision:4884; number_of_response:1; }","duration":"120.967475ms","start":"2026-04-22T06:08:15.925995Z","end":"2026-04-22T06:08:16.046963Z","steps":["trace[1379220518] 'process raft request' (duration: 120.897564ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:16.047152Z","caller":"traceutil/trace.go:171","msg":"trace[304957959] transaction","detail":"{read_only:false; response_revision:4881; number_of_response:1; }","duration":"125.277669ms","start":"2026-04-22T06:08:15.921864Z","end":"2026-04-22T06:08:16.047142Z","steps":["trace[304957959] 'process raft request' (duration: 124.89492ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:16.047242Z","caller":"traceutil/trace.go:171","msg":"trace[961569067] transaction","detail":"{read_only:false; response_revision:4883; number_of_response:1; }","duration":"125.145547ms","start":"2026-04-22T06:08:15.921967Z","end":"2026-04-22T06:08:16.047112Z","steps":["trace[961569067] 'process raft request' (duration: 124.851579ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:16.047311Z","caller":"traceutil/trace.go:171","msg":"trace[2076734104] transaction","detail":"{read_only:false; response_revision:4879; number_of_response:1; }","duration":"125.702238ms","start":"2026-04-22T06:08:15.921596Z","end":"2026-04-22T06:08:16.047298Z","steps":["trace[2076734104] 'process raft request' (duration: 95.727311ms)","trace[2076734104] 'compare' (duration: 29.296722ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:08:16.047651Z","caller":"traceutil/trace.go:171","msg":"trace[1749307846] transaction","detail":"{read_only:false; response_revision:4880; number_of_response:1; }","duration":"125.892843ms","start":"2026-04-22T06:08:15.92167Z","end":"2026-04-22T06:08:16.047563Z","steps":["trace[1749307846] 'process raft request' (duration: 125.047373ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:08:16.326643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.499292ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T06:08:16.326759Z","caller":"traceutil/trace.go:171","msg":"trace[144756780] linearizableReadLoop","detail":"{readStateIndex:5077; appliedIndex:5076; }","duration":"113.245131ms","start":"2026-04-22T06:08:16.213496Z","end":"2026-04-22T06:08:16.326741Z","steps":["trace[144756780] 'read index received' (duration: 40.541µs)","trace[144756780] 'applied index is now lower than readState.Index' (duration: 113.20341ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T06:08:16.326846Z","caller":"traceutil/trace.go:171","msg":"trace[1512370161] transaction","detail":"{read_only:false; response_revision:4889; number_of_response:1; }","duration":"188.369358ms","start":"2026-04-22T06:08:16.138445Z","end":"2026-04-22T06:08:16.326814Z","steps":["trace[1512370161] 'process raft request' (duration: 14.578579ms)","trace[1512370161] 'compare' (duration: 173.342629ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:08:16.326922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.419746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3243"} {"level":"info","ts":"2026-04-22T06:08:16.327046Z","caller":"traceutil/trace.go:171","msg":"trace[1003881119] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4889; }","duration":"113.577219ms","start":"2026-04-22T06:08:16.213452Z","end":"2026-04-22T06:08:16.327029Z","steps":["trace[1003881119] 'agreement among raft nodes before linearized reading' (duration: 113.362164ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:08:52.88052Z","caller":"traceutil/trace.go:171","msg":"trace[1253992787] transaction","detail":"{read_only:false; response_revision:5235; number_of_response:1; }","duration":"139.532612ms","start":"2026-04-22T06:08:52.74096Z","end":"2026-04-22T06:08:52.880492Z","steps":["trace[1253992787] 'process raft request' (duration: 139.297638ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T06:09:34.326785Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2862} {"level":"info","ts":"2026-04-22T06:09:34.42198Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2862,"took":"93.848529ms","hash":3631227168,"current-db-size-bytes":52396032,"current-db-size":"52 MB","current-db-size-in-use-bytes":28864512,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-22T06:09:34.422031Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3631227168,"revision":2862,"compact-revision":-1} {"level":"info","ts":"2026-04-22T06:14:34.332722Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5531} {"level":"info","ts":"2026-04-22T06:14:34.412754Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5531,"took":"77.592599ms","hash":4210288458,"current-db-size-bytes":52396032,"current-db-size":"52 MB","current-db-size-in-use-bytes":18313216,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-22T06:14:34.412854Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4210288458,"revision":5531,"compact-revision":2862} {"level":"warn","ts":"2026-04-22T06:15:02.904991Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656052181030460959,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-22T06:15:02.932861Z","caller":"traceutil/trace.go:171","msg":"trace[875125835] transaction","detail":"{read_only:false; response_revision:7532; number_of_response:1; }","duration":"747.726911ms","start":"2026-04-22T06:15:02.185104Z","end":"2026-04-22T06:15:02.93283Z","steps":["trace[875125835] 'process raft request' (duration: 746.141346ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:15:02.933028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:15:02.185095Z","time spent":"747.845905ms","remote":"127.0.0.1:41810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T06:15:02.935395Z","caller":"traceutil/trace.go:171","msg":"trace[690106633] linearizableReadLoop","detail":"{readStateIndex:7815; appliedIndex:7813; }","duration":"742.595363ms","start":"2026-04-22T06:15:02.192768Z","end":"2026-04-22T06:15:02.935363Z","steps":["trace[690106633] 'read index received' (duration: 738.487922ms)","trace[690106633] 'applied index is now lower than readState.Index' (duration: 4.106291ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T06:15:02.935775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"730.921259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/expand-controller\" ","response":"range_response_count:1 size:199"} {"level":"info","ts":"2026-04-22T06:15:02.935826Z","caller":"traceutil/trace.go:171","msg":"trace[657165860] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/expand-controller; range_end:; response_count:1; response_revision:7533; }","duration":"730.989732ms","start":"2026-04-22T06:15:02.204818Z","end":"2026-04-22T06:15:02.935808Z","steps":["trace[657165860] 'agreement among raft nodes before linearized reading' (duration: 730.811046ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:15:02.935847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:15:02.204807Z","time spent":"731.034934ms","remote":"127.0.0.1:41766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":222,"request content":"key:\"/registry/serviceaccounts/kube-system/expand-controller\" "} {"level":"warn","ts":"2026-04-22T06:15:02.936036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"663.555877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-22T06:15:02.936061Z","caller":"traceutil/trace.go:171","msg":"trace[1159820085] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:7533; }","duration":"663.61531ms","start":"2026-04-22T06:15:02.27244Z","end":"2026-04-22T06:15:02.936056Z","steps":["trace[1159820085] 'agreement among raft nodes before linearized reading' (duration: 663.544377ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:15:02.936075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:15:02.272425Z","time spent":"663.647191ms","remote":"127.0.0.1:41752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-22T06:15:02.93632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"743.501924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:86 size:63848"} {"level":"info","ts":"2026-04-22T06:15:02.936365Z","caller":"traceutil/trace.go:171","msg":"trace[944818898] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:86; response_revision:7533; }","duration":"743.64728ms","start":"2026-04-22T06:15:02.192703Z","end":"2026-04-22T06:15:02.93635Z","steps":["trace[944818898] 'agreement among raft nodes before linearized reading' (duration: 742.855872ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T06:15:02.936447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T06:15:02.192672Z","time spent":"743.762303ms","remote":"127.0.0.1:41664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":86,"response size":63871,"request content":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 "}