{"level":"warn","ts":"2026-04-10T05:15:33.269661Z","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-10T05:15:33.269753Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.235: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.235:2380","--initial-cluster=instance=https://199.204.45.235:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.235:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.235: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-10T05:15:33.269821Z","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-10T05:15:33.269839Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-04-10T05:15:33.269862Z","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-10T05:15:33.270494Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"]} {"level":"info","ts":"2026-04-10T05:15:33.270589Z","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":16,"max-cpu-available":16,"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.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.235: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-10T05:15:33.27649Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.193457ms"} {"level":"info","ts":"2026-04-10T05:15:33.283112Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"aab6040abcf11","cluster-id":"2bae7d3d8857c059"} {"level":"info","ts":"2026-04-10T05:15:33.283269Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=()"} {"level":"info","ts":"2026-04-10T05:15:33.28332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 0"} {"level":"info","ts":"2026-04-10T05:15:33.283474Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft aab6040abcf11 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-10T05:15:33.283506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 1"} {"level":"info","ts":"2026-04-10T05:15:33.283583Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"warn","ts":"2026-04-10T05:15:33.289471Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-10T05:15:33.291813Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-10T05:15:33.293604Z","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-10T05:15:33.296633Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"aab6040abcf11","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-10T05:15:33.296892Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"aab6040abcf11","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-10T05:15:33.297268Z","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-10T05:15:33.297333Z","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-10T05:15:33.297351Z","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-10T05:15:33.29818Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"info","ts":"2026-04-10T05:15:33.300402Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","added-peer-id":"aab6040abcf11","added-peer-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-04-10T05:15:33.304407Z","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-10T05:15:33.304536Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-04-10T05:15:33.304594Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-04-10T05:15:33.305095Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-10T05:15:33.305008Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"aab6040abcf11","initial-advertise-peer-urls":["https://199.204.45.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-10T05:15:33.58742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 is starting a new election at term 1"} {"level":"info","ts":"2026-04-10T05:15:33.587515Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-10T05:15:33.587562Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgPreVoteResp from aab6040abcf11 at term 1"} {"level":"info","ts":"2026-04-10T05:15:33.587592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became candidate at term 2"} {"level":"info","ts":"2026-04-10T05:15:33.587599Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgVoteResp from aab6040abcf11 at term 2"} {"level":"info","ts":"2026-04-10T05:15:33.587609Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became leader at term 2"} {"level":"info","ts":"2026-04-10T05:15:33.587619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: aab6040abcf11 elected leader aab6040abcf11 at term 2"} {"level":"info","ts":"2026-04-10T05:15:33.591601Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T05:15:33.603888Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-10T05:15:33.603896Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"aab6040abcf11","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.235:2379]}","request-path":"/0/members/aab6040abcf11/attributes","cluster-id":"2bae7d3d8857c059","publish-timeout":"7s"} {"level":"info","ts":"2026-04-10T05:15:33.604074Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-10T05:15:33.60451Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-10T05:15:33.604534Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-10T05:15:33.608279Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.235:2379"} {"level":"info","ts":"2026-04-10T05:15:33.609297Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-10T05:15:33.621633Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T05:15:33.621915Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T05:15:33.621989Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T05:16:11.76287Z","caller":"traceutil/trace.go:171","msg":"trace[409153211] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:645; }","duration":"114.85051ms","start":"2026-04-10T05:16:11.647992Z","end":"2026-04-10T05:16:11.762843Z","steps":["trace[409153211] 'read index received' (duration: 114.639915ms)","trace[409153211] 'applied index is now lower than readState.Index' (duration: 209.585µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T05:16:11.762999Z","caller":"traceutil/trace.go:171","msg":"trace[553281150] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"118.655938ms","start":"2026-04-10T05:16:11.644306Z","end":"2026-04-10T05:16:11.762962Z","steps":["trace[553281150] 'process raft request' (duration: 118.384363ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:16:11.763256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.235787ms","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-10T05:16:11.763469Z","caller":"traceutil/trace.go:171","msg":"trace[319241807] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:618; }","duration":"115.392732ms","start":"2026-04-10T05:16:11.647941Z","end":"2026-04-10T05:16:11.763334Z","steps":["trace[319241807] 'agreement among raft nodes before linearized reading' (duration: 115.034043ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:16:11.888261Z","caller":"traceutil/trace.go:171","msg":"trace[1881477062] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"124.944389ms","start":"2026-04-10T05:16:11.763264Z","end":"2026-04-10T05:16:11.888209Z","steps":["trace[1881477062] 'process raft request' (duration: 102.962553ms)","trace[1881477062] 'compare' (duration: 21.488636ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T05:16:11.888298Z","caller":"traceutil/trace.go:171","msg":"trace[1709289428] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:646; }","duration":"120.087017ms","start":"2026-04-10T05:16:11.768149Z","end":"2026-04-10T05:16:11.888236Z","steps":["trace[1709289428] 'read index received' (duration: 97.859247ms)","trace[1709289428] 'applied index is now lower than readState.Index' (duration: 22.22309ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T05:16:11.888363Z","caller":"traceutil/trace.go:171","msg":"trace[484514247] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"119.240439ms","start":"2026-04-10T05:16:11.769082Z","end":"2026-04-10T05:16:11.888323Z","steps":["trace[484514247] 'process raft request' (duration: 119.049045ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:16:11.964346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.751877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T05:16:11.964436Z","caller":"traceutil/trace.go:171","msg":"trace[1445164116] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:620; }","duration":"101.88354ms","start":"2026-04-10T05:16:11.862535Z","end":"2026-04-10T05:16:11.964418Z","steps":["trace[1445164116] 'agreement among raft nodes before linearized reading' (duration: 101.721607ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:16:11.964458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.315447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jkc82\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-04-10T05:16:11.964446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.928081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T05:16:11.964499Z","caller":"traceutil/trace.go:171","msg":"trace[431660074] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:620; }","duration":"102.027613ms","start":"2026-04-10T05:16:11.86246Z","end":"2026-04-10T05:16:11.964488Z","steps":["trace[431660074] 'agreement among raft nodes before linearized reading' (duration: 101.945131ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:16:11.964498Z","caller":"traceutil/trace.go:171","msg":"trace[1273982080] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jkc82; range_end:; response_count:1; response_revision:620; }","duration":"196.380958ms","start":"2026-04-10T05:16:11.768104Z","end":"2026-04-10T05:16:11.964485Z","steps":["trace[1273982080] 'agreement among raft nodes before linearized reading' (duration: 120.369473ms)","trace[1273982080] 'range keys from in-memory index tree' (duration: 75.891982ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T05:16:11.964343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.125655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T05:16:11.964648Z","caller":"traceutil/trace.go:171","msg":"trace[528586826] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:620; }","duration":"101.500662ms","start":"2026-04-10T05:16:11.863141Z","end":"2026-04-10T05:16:11.964642Z","steps":["trace[528586826] 'agreement among raft nodes before linearized reading' (duration: 101.112944ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:16:12.124401Z","caller":"traceutil/trace.go:171","msg":"trace[583462645] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"143.995292ms","start":"2026-04-10T05:16:11.980374Z","end":"2026-04-10T05:16:12.124369Z","steps":["trace[583462645] 'process raft request' (duration: 143.751527ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:16:12.608318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.302175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T05:16:12.608368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.54953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T05:16:12.608637Z","caller":"traceutil/trace.go:171","msg":"trace[442901050] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:622; }","duration":"250.701593ms","start":"2026-04-10T05:16:12.357908Z","end":"2026-04-10T05:16:12.608609Z","steps":["trace[442901050] 'range keys from in-memory index tree' (duration: 250.228614ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:16:12.60818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.365055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T05:16:12.608594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.856316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T05:16:12.608743Z","caller":"traceutil/trace.go:171","msg":"trace[1394120208] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:622; }","duration":"304.961858ms","start":"2026-04-10T05:16:12.303735Z","end":"2026-04-10T05:16:12.608697Z","steps":["trace[1394120208] 'count revisions from in-memory index tree' (duration: 304.230983ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:16:12.60877Z","caller":"traceutil/trace.go:171","msg":"trace[42316221] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:622; }","duration":"334.334966ms","start":"2026-04-10T05:16:12.274412Z","end":"2026-04-10T05:16:12.608747Z","steps":["trace[42316221] 'range keys from in-memory index tree' (duration: 333.729394ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:16:12.608823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T05:16:12.303721Z","time spent":"305.07681ms","remote":"127.0.0.1:38378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":26,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-10T05:16:12.60891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.600799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T05:16:12.60888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.863976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T05:16:12.608987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.135581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T05:16:12.609021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.00124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T05:16:12.609038Z","caller":"traceutil/trace.go:171","msg":"trace[367970643] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:622; }","duration":"304.180102ms","start":"2026-04-10T05:16:12.304842Z","end":"2026-04-10T05:16:12.609022Z","steps":["trace[367970643] 'range keys from in-memory index tree' (duration: 304.028448ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:16:12.609032Z","caller":"traceutil/trace.go:171","msg":"trace[401344999] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:622; }","duration":"333.096501ms","start":"2026-04-10T05:16:12.2759Z","end":"2026-04-10T05:16:12.608996Z","steps":["trace[401344999] 'range keys from in-memory index tree' (duration: 332.758573ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:16:12.609077Z","caller":"traceutil/trace.go:171","msg":"trace[1801280285] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:622; }","duration":"252.103492ms","start":"2026-04-10T05:16:12.356958Z","end":"2026-04-10T05:16:12.609061Z","steps":["trace[1801280285] 'count revisions from in-memory index tree' (duration: 251.906789ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:16:12.609084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T05:16:12.304806Z","time spent":"304.268503ms","remote":"127.0.0.1:38378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":26,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-10T05:16:12.608824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T05:16:12.27438Z","time spent":"334.428518ms","remote":"127.0.0.1:38368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":26,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-10T05:16:12.609138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T05:16:12.27588Z","time spent":"333.237653ms","remote":"127.0.0.1:38368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":26,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 "} {"level":"info","ts":"2026-04-10T05:16:12.608951Z","caller":"traceutil/trace.go:171","msg":"trace[293699557] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:622; }","duration":"401.659831ms","start":"2026-04-10T05:16:12.207277Z","end":"2026-04-10T05:16:12.608937Z","steps":["trace[293699557] 'range keys from in-memory index tree' (duration: 401.530208ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:16:12.609243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T05:16:12.207263Z","time spent":"401.970667ms","remote":"127.0.0.1:34122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-10T05:16:12.6092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.697114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T05:16:12.608734Z","caller":"traceutil/trace.go:171","msg":"trace[350219042] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:622; }","duration":"304.854995ms","start":"2026-04-10T05:16:12.303768Z","end":"2026-04-10T05:16:12.608622Z","steps":["trace[350219042] 'range keys from in-memory index tree' (duration: 304.474098ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:16:12.609402Z","caller":"traceutil/trace.go:171","msg":"trace[757470995] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:622; }","duration":"334.94868ms","start":"2026-04-10T05:16:12.27439Z","end":"2026-04-10T05:16:12.609339Z","steps":["trace[757470995] 'count revisions from in-memory index tree' (duration: 334.53542ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:16:12.60893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.96653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T05:16:12.609474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T05:16:12.274333Z","time spent":"335.122023ms","remote":"127.0.0.1:38368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":26,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-10T05:16:12.609452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T05:16:12.303753Z","time spent":"305.645493ms","remote":"127.0.0.1:38378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":26,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"info","ts":"2026-04-10T05:16:12.609596Z","caller":"traceutil/trace.go:171","msg":"trace[460507289] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:622; }","duration":"252.682746ms","start":"2026-04-10T05:16:12.356896Z","end":"2026-04-10T05:16:12.609579Z","steps":["trace[460507289] 'range keys from in-memory index tree' (duration: 251.817997ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:16:12.650768Z","caller":"traceutil/trace.go:171","msg":"trace[1447178918] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:651; }","duration":"116.674197ms","start":"2026-04-10T05:16:12.534062Z","end":"2026-04-10T05:16:12.650736Z","steps":["trace[1447178918] 'read index received' (duration: 115.526423ms)","trace[1447178918] 'applied index is now lower than readState.Index' (duration: 1.146424ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T05:16:12.650914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.84928ms","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-10T05:16:12.651006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.85182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T05:16:12.65115Z","caller":"traceutil/trace.go:171","msg":"trace[1954761709] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"244.507025ms","start":"2026-04-10T05:16:12.406404Z","end":"2026-04-10T05:16:12.650911Z","steps":["trace[1954761709] 'process raft request' (duration: 243.463364ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:16:12.651243Z","caller":"traceutil/trace.go:171","msg":"trace[208386883] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:623; }","duration":"116.948452ms","start":"2026-04-10T05:16:12.534004Z","end":"2026-04-10T05:16:12.650953Z","steps":["trace[208386883] 'agreement among raft nodes before linearized reading' (duration: 116.85619ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:16:12.651309Z","caller":"traceutil/trace.go:171","msg":"trace[312881139] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:623; }","duration":"117.000333ms","start":"2026-04-10T05:16:12.534047Z","end":"2026-04-10T05:16:12.651048Z","steps":["trace[312881139] 'agreement among raft nodes before linearized reading' (duration: 116.874611ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:16:39.132733Z","caller":"traceutil/trace.go:171","msg":"trace[1643913040] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"204.072228ms","start":"2026-04-10T05:16:38.928631Z","end":"2026-04-10T05:16:39.132704Z","steps":["trace[1643913040] 'process raft request' (duration: 203.880413ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:17:10.476028Z","caller":"traceutil/trace.go:171","msg":"trace[1267929831] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"182.489865ms","start":"2026-04-10T05:17:10.293481Z","end":"2026-04-10T05:17:10.475971Z","steps":["trace[1267929831] 'process raft request' (duration: 181.697549ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:17:30.410567Z","caller":"traceutil/trace.go:171","msg":"trace[1555519865] transaction","detail":"{read_only:false; response_revision:1470; number_of_response:1; }","duration":"101.096289ms","start":"2026-04-10T05:17:30.309439Z","end":"2026-04-10T05:17:30.410535Z","steps":["trace[1555519865] 'process raft request' (duration: 90.771463ms)","trace[1555519865] 'compare' (duration: 10.194094ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T05:17:30.453112Z","caller":"traceutil/trace.go:171","msg":"trace[1888392325] linearizableReadLoop","detail":"{readStateIndex:1523; appliedIndex:1521; }","duration":"109.925225ms","start":"2026-04-10T05:17:30.343163Z","end":"2026-04-10T05:17:30.453089Z","steps":["trace[1888392325] 'read index received' (duration: 57.048819ms)","trace[1888392325] 'applied index is now lower than readState.Index' (duration: 52.874676ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T05:17:30.453187Z","caller":"traceutil/trace.go:171","msg":"trace[1641812793] transaction","detail":"{read_only:false; response_revision:1471; number_of_response:1; }","duration":"123.083958ms","start":"2026-04-10T05:17:30.330061Z","end":"2026-04-10T05:17:30.453145Z","steps":["trace[1641812793] 'process raft request' (duration: 122.872734ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:17:30.453388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.205591ms","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-10T05:17:30.453453Z","caller":"traceutil/trace.go:171","msg":"trace[1234308186] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1471; }","duration":"110.341974ms","start":"2026-04-10T05:17:30.343096Z","end":"2026-04-10T05:17:30.453438Z","steps":["trace[1234308186] 'agreement among raft nodes before linearized reading' (duration: 110.092669ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:17:48.108128Z","caller":"traceutil/trace.go:171","msg":"trace[902846541] transaction","detail":"{read_only:false; response_revision:1771; number_of_response:1; }","duration":"118.293244ms","start":"2026-04-10T05:17:47.98981Z","end":"2026-04-10T05:17:48.108103Z","steps":["trace[902846541] 'process raft request' (duration: 118.10639ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:17:48.114808Z","caller":"traceutil/trace.go:171","msg":"trace[1750233088] transaction","detail":"{read_only:false; response_revision:1772; number_of_response:1; }","duration":"123.220572ms","start":"2026-04-10T05:17:47.991553Z","end":"2026-04-10T05:17:48.114774Z","steps":["trace[1750233088] 'process raft request' (duration: 123.028058ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:17:56.456065Z","caller":"traceutil/trace.go:171","msg":"trace[1925412580] linearizableReadLoop","detail":"{readStateIndex:1966; appliedIndex:1965; }","duration":"249.472094ms","start":"2026-04-10T05:17:56.206569Z","end":"2026-04-10T05:17:56.456041Z","steps":["trace[1925412580] 'read index received' (duration: 249.31557ms)","trace[1925412580] 'applied index is now lower than readState.Index' (duration: 155.524µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T05:17:56.45615Z","caller":"traceutil/trace.go:171","msg":"trace[2105401312] transaction","detail":"{read_only:false; response_revision:1887; number_of_response:1; }","duration":"300.333489ms","start":"2026-04-10T05:17:56.155771Z","end":"2026-04-10T05:17:56.456104Z","steps":["trace[2105401312] 'process raft request' (duration: 300.088083ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:17:56.456312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.870174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6106ee51-ef58-4df0-b157-07a9a57a8ac4\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-10T05:17:56.456979Z","caller":"traceutil/trace.go:171","msg":"trace[882684560] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6106ee51-ef58-4df0-b157-07a9a57a8ac4; range_end:; response_count:1; response_revision:1887; }","duration":"156.580718ms","start":"2026-04-10T05:17:56.30037Z","end":"2026-04-10T05:17:56.456951Z","steps":["trace[882684560] 'agreement among raft nodes before linearized reading' (duration: 155.813883ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:17:56.456465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.649417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T05:17:56.457174Z","caller":"traceutil/trace.go:171","msg":"trace[836390217] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1887; }","duration":"250.633787ms","start":"2026-04-10T05:17:56.206529Z","end":"2026-04-10T05:17:56.457163Z","steps":["trace[836390217] 'agreement among raft nodes before linearized reading' (duration: 249.613487ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:17:56.457516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T05:17:56.15576Z","time spent":"301.048994ms","remote":"127.0.0.1:34332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T05:17:56.597406Z","caller":"traceutil/trace.go:171","msg":"trace[1191221677] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"131.404625ms","start":"2026-04-10T05:17:56.465969Z","end":"2026-04-10T05:17:56.597373Z","steps":["trace[1191221677] 'process raft request' (duration: 131.273562ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:17:56.790311Z","caller":"traceutil/trace.go:171","msg":"trace[259559817] transaction","detail":"{read_only:false; response_revision:1893; number_of_response:1; }","duration":"164.098608ms","start":"2026-04-10T05:17:56.626183Z","end":"2026-04-10T05:17:56.790282Z","steps":["trace[259559817] 'process raft request' (duration: 164.021547ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:17:56.790374Z","caller":"traceutil/trace.go:171","msg":"trace[192197599] transaction","detail":"{read_only:false; response_revision:1892; number_of_response:1; }","duration":"172.336733ms","start":"2026-04-10T05:17:56.617995Z","end":"2026-04-10T05:17:56.790332Z","steps":["trace[192197599] 'process raft request' (duration: 172.014877ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:17:57.162591Z","caller":"traceutil/trace.go:171","msg":"trace[238444507] transaction","detail":"{read_only:false; response_revision:1894; number_of_response:1; }","duration":"393.394968ms","start":"2026-04-10T05:17:56.769163Z","end":"2026-04-10T05:17:57.162558Z","steps":["trace[238444507] 'process raft request' (duration: 392.9839ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:17:57.162935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T05:17:56.769135Z","time spent":"393.598903ms","remote":"127.0.0.1:34332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T05:17:57.182002Z","caller":"traceutil/trace.go:171","msg":"trace[586584043] transaction","detail":"{read_only:false; response_revision:1895; number_of_response:1; }","duration":"385.409809ms","start":"2026-04-10T05:17:56.79655Z","end":"2026-04-10T05:17:57.18196Z","steps":["trace[586584043] 'process raft request' (duration: 385.163764ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:17:57.182322Z","caller":"traceutil/trace.go:171","msg":"trace[216108725] linearizableReadLoop","detail":"{readStateIndex:1977; appliedIndex:1972; }","duration":"364.331098ms","start":"2026-04-10T05:17:56.817967Z","end":"2026-04-10T05:17:57.182298Z","steps":["trace[216108725] 'read index received' (duration: 344.271477ms)","trace[216108725] 'applied index is now lower than readState.Index' (duration: 20.05435ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T05:17:57.182391Z","caller":"traceutil/trace.go:171","msg":"trace[136309941] transaction","detail":"{read_only:false; response_revision:1898; number_of_response:1; }","duration":"385.080632ms","start":"2026-04-10T05:17:56.797285Z","end":"2026-04-10T05:17:57.182366Z","steps":["trace[136309941] 'process raft request' (duration: 384.932759ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:17:57.182501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T05:17:56.797252Z","time spent":"385.180374ms","remote":"127.0.0.1:34340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1472,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T05:17:57.182571Z","caller":"traceutil/trace.go:171","msg":"trace[1675468453] transaction","detail":"{read_only:false; response_revision:1897; number_of_response:1; }","duration":"385.390808ms","start":"2026-04-10T05:17:56.797148Z","end":"2026-04-10T05:17:57.182539Z","steps":["trace[1675468453] 'process raft request' (duration: 384.97391ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:17:57.182643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.664554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.235\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-10T05:17:57.182749Z","caller":"traceutil/trace.go:171","msg":"trace[1319539135] range","detail":"{range_begin:/registry/masterleases/199.204.45.235; range_end:; response_count:1; response_revision:1898; }","duration":"364.797786ms","start":"2026-04-10T05:17:56.817932Z","end":"2026-04-10T05:17:57.182715Z","steps":["trace[1319539135] 'agreement among raft nodes before linearized reading' (duration: 364.48591ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:17:57.182755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T05:17:56.796522Z","time spent":"385.602582ms","remote":"127.0.0.1:34340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1530,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T05:17:57.182793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T05:17:56.79714Z","time spent":"385.529101ms","remote":"127.0.0.1:34244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":894,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T05:17:57.18281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T05:17:56.817919Z","time spent":"364.878578ms","remote":"127.0.0.1:34138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.235\" "} {"level":"info","ts":"2026-04-10T05:17:57.183075Z","caller":"traceutil/trace.go:171","msg":"trace[1150787465] transaction","detail":"{read_only:false; response_revision:1896; number_of_response:1; }","duration":"385.240245ms","start":"2026-04-10T05:17:56.796996Z","end":"2026-04-10T05:17:57.182237Z","steps":["trace[1150787465] 'process raft request' (duration: 384.885158ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:17:57.183277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T05:17:56.796987Z","time spent":"386.173764ms","remote":"127.0.0.1:34244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":978,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T05:17:57.187109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.022982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18a4e71f3087c4e3\" ","response":"range_response_count:1 size:982"} {"level":"info","ts":"2026-04-10T05:17:57.187184Z","caller":"traceutil/trace.go:171","msg":"trace[1707015194] range","detail":"{range_begin:/registry/events/openstack/datadir-percona-xtradb-pxc-0.18a4e71f3087c4e3; range_end:; response_count:1; response_revision:1899; }","duration":"282.139816ms","start":"2026-04-10T05:17:56.90502Z","end":"2026-04-10T05:17:57.187159Z","steps":["trace[1707015194] 'agreement among raft nodes before linearized reading' (duration: 280.696216ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:18:04.692972Z","caller":"traceutil/trace.go:171","msg":"trace[66008740] linearizableReadLoop","detail":"{readStateIndex:2049; appliedIndex:2048; }","duration":"178.968585ms","start":"2026-04-10T05:18:04.513971Z","end":"2026-04-10T05:18:04.69294Z","steps":["trace[66008740] 'read index received' (duration: 178.857423ms)","trace[66008740] 'applied index is now lower than readState.Index' (duration: 109.912µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T05:18:04.693025Z","caller":"traceutil/trace.go:171","msg":"trace[1567774691] transaction","detail":"{read_only:false; response_revision:1968; number_of_response:1; }","duration":"195.602678ms","start":"2026-04-10T05:18:04.497378Z","end":"2026-04-10T05:18:04.692981Z","steps":["trace[1567774691] 'process raft request' (duration: 195.385433ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:18:04.693266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.274771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-10T05:18:04.693324Z","caller":"traceutil/trace.go:171","msg":"trace[1507069440] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1968; }","duration":"179.402253ms","start":"2026-04-10T05:18:04.513908Z","end":"2026-04-10T05:18:04.69331Z","steps":["trace[1507069440] 'agreement among raft nodes before linearized reading' (duration: 179.169979ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:18:04.700433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.449176ms","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-10T05:18:04.700525Z","caller":"traceutil/trace.go:171","msg":"trace[1428994585] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1970; }","duration":"101.718342ms","start":"2026-04-10T05:18:04.598787Z","end":"2026-04-10T05:18:04.700505Z","steps":["trace[1428994585] 'agreement among raft nodes before linearized reading' (duration: 100.828204ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:18:08.956315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.316237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-10T05:18:08.956429Z","caller":"traceutil/trace.go:171","msg":"trace[1460657659] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1998; }","duration":"106.49144ms","start":"2026-04-10T05:18:08.849911Z","end":"2026-04-10T05:18:08.956403Z","steps":["trace[1460657659] 'range keys from in-memory index tree' (duration: 106.086502ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:18:35.567179Z","caller":"traceutil/trace.go:171","msg":"trace[1252732486] transaction","detail":"{read_only:false; response_revision:2160; number_of_response:1; }","duration":"153.515157ms","start":"2026-04-10T05:18:35.413629Z","end":"2026-04-10T05:18:35.567144Z","steps":["trace[1252732486] 'process raft request' (duration: 122.276385ms)","trace[1252732486] 'compare' (duration: 30.564689ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T05:18:40.9536Z","caller":"traceutil/trace.go:171","msg":"trace[488887508] transaction","detail":"{read_only:false; response_revision:2184; number_of_response:1; }","duration":"111.351397ms","start":"2026-04-10T05:18:40.842207Z","end":"2026-04-10T05:18:40.953558Z","steps":["trace[488887508] 'process raft request' (duration: 111.115232ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:18:41.079089Z","caller":"traceutil/trace.go:171","msg":"trace[1575675512] transaction","detail":"{read_only:false; response_revision:2185; number_of_response:1; }","duration":"119.872937ms","start":"2026-04-10T05:18:40.959185Z","end":"2026-04-10T05:18:41.079058Z","steps":["trace[1575675512] 'process raft request' (duration: 119.675262ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:18:41.188012Z","caller":"traceutil/trace.go:171","msg":"trace[1125455297] transaction","detail":"{read_only:false; response_revision:2186; number_of_response:1; }","duration":"228.647572ms","start":"2026-04-10T05:18:40.959333Z","end":"2026-04-10T05:18:41.187981Z","steps":["trace[1125455297] 'process raft request' (duration: 214.572161ms)","trace[1125455297] 'compare' (duration: 13.848266ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T05:18:41.188129Z","caller":"traceutil/trace.go:171","msg":"trace[1651252781] linearizableReadLoop","detail":"{readStateIndex:2276; appliedIndex:2273; }","duration":"211.521521ms","start":"2026-04-10T05:18:40.976575Z","end":"2026-04-10T05:18:41.188097Z","steps":["trace[1651252781] 'read index received' (duration: 102.368118ms)","trace[1651252781] 'applied index is now lower than readState.Index' (duration: 109.150383ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T05:18:41.188243Z","caller":"traceutil/trace.go:171","msg":"trace[1231100444] transaction","detail":"{read_only:false; response_revision:2187; number_of_response:1; }","duration":"228.827246ms","start":"2026-04-10T05:18:40.959389Z","end":"2026-04-10T05:18:41.188216Z","steps":["trace[1231100444] 'process raft request' (duration: 228.527669ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:18:41.188501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.898859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-10T05:18:41.188629Z","caller":"traceutil/trace.go:171","msg":"trace[917491686] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2187; }","duration":"212.098383ms","start":"2026-04-10T05:18:40.976503Z","end":"2026-04-10T05:18:41.188601Z","steps":["trace[917491686] 'agreement among raft nodes before linearized reading' (duration: 211.729405ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:18:47.376295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.896972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-10T05:18:47.376448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.999958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-04-10T05:18:47.376446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.938905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-10T05:18:47.376555Z","caller":"traceutil/trace.go:171","msg":"trace[29577943] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2218; }","duration":"159.119998ms","start":"2026-04-10T05:18:47.217408Z","end":"2026-04-10T05:18:47.376528Z","steps":["trace[29577943] 'range keys from in-memory index tree' (duration: 158.671979ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:18:47.376571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.627358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-10T05:18:47.376567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.520039ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T05:18:47.376692Z","caller":"traceutil/trace.go:171","msg":"trace[1135717216] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2218; }","duration":"132.644592ms","start":"2026-04-10T05:18:47.244031Z","end":"2026-04-10T05:18:47.376675Z","steps":["trace[1135717216] 'range keys from in-memory index tree' (duration: 132.509378ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:18:47.376662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.627331ms","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-10T05:18:47.376694Z","caller":"traceutil/trace.go:171","msg":"trace[1780964692] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2218; }","duration":"272.808461ms","start":"2026-04-10T05:18:47.103858Z","end":"2026-04-10T05:18:47.376666Z","steps":["trace[1780964692] 'range keys from in-memory index tree' (duration: 272.326351ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:18:47.376446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.929156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T05:18:47.376756Z","caller":"traceutil/trace.go:171","msg":"trace[1283772670] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2218; }","duration":"130.757214ms","start":"2026-04-10T05:18:47.245977Z","end":"2026-04-10T05:18:47.376734Z","steps":["trace[1283772670] 'range keys from in-memory index tree' (duration: 130.429987ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:18:47.37681Z","caller":"traceutil/trace.go:171","msg":"trace[1993598036] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2218; }","duration":"138.334425ms","start":"2026-04-10T05:18:47.238448Z","end":"2026-04-10T05:18:47.376782Z","steps":["trace[1993598036] 'range keys from in-memory index tree' (duration: 137.788383ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:18:47.376872Z","caller":"traceutil/trace.go:171","msg":"trace[111866146] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2218; }","duration":"135.10769ms","start":"2026-04-10T05:18:47.241387Z","end":"2026-04-10T05:18:47.376495Z","steps":["trace[111866146] 'range keys from in-memory index tree' (duration: 134.788283ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:18:47.376409Z","caller":"traceutil/trace.go:171","msg":"trace[932313294] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2218; }","duration":"166.076357ms","start":"2026-04-10T05:18:47.210304Z","end":"2026-04-10T05:18:47.376381Z","steps":["trace[932313294] 'range keys from in-memory index tree' (duration: 165.616627ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:18:47.678128Z","caller":"traceutil/trace.go:171","msg":"trace[50505692] transaction","detail":"{read_only:false; response_revision:2219; number_of_response:1; }","duration":"296.235058ms","start":"2026-04-10T05:18:47.381856Z","end":"2026-04-10T05:18:47.678091Z","steps":["trace[50505692] 'process raft request' (duration: 296.026054ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:18:47.821445Z","caller":"traceutil/trace.go:171","msg":"trace[1773570677] transaction","detail":"{read_only:false; response_revision:2220; number_of_response:1; }","duration":"439.244994ms","start":"2026-04-10T05:18:47.382143Z","end":"2026-04-10T05:18:47.821388Z","steps":["trace[1773570677] 'process raft request' (duration: 422.860658ms)","trace[1773570677] 'compare' (duration: 16.183242ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T05:18:47.821594Z","caller":"traceutil/trace.go:171","msg":"trace[2063079620] transaction","detail":"{read_only:false; response_revision:2222; number_of_response:1; }","duration":"439.025859ms","start":"2026-04-10T05:18:47.382554Z","end":"2026-04-10T05:18:47.82158Z","steps":["trace[2063079620] 'process raft request' (duration: 438.794125ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:18:47.821708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T05:18:47.382093Z","time spent":"439.475688ms","remote":"127.0.0.1:34332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T05:18:47.821754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T05:18:47.382542Z","time spent":"439.116152ms","remote":"127.0.0.1:34332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T05:18:47.821464Z","caller":"traceutil/trace.go:171","msg":"trace[280959995] transaction","detail":"{read_only:false; response_revision:2221; number_of_response:1; }","duration":"439.02113ms","start":"2026-04-10T05:18:47.382377Z","end":"2026-04-10T05:18:47.821398Z","steps":["trace[280959995] 'process raft request' (duration: 438.926768ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:18:47.822114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T05:18:47.382351Z","time spent":"439.582711ms","remote":"127.0.0.1:34332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T05:18:47.822238Z","caller":"traceutil/trace.go:171","msg":"trace[1564082800] transaction","detail":"{read_only:false; response_revision:2223; number_of_response:1; }","duration":"397.448513ms","start":"2026-04-10T05:18:47.424617Z","end":"2026-04-10T05:18:47.822066Z","steps":["trace[1564082800] 'process raft request' (duration: 396.912801ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:18:47.822465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T05:18:47.424602Z","time spent":"397.741148ms","remote":"127.0.0.1:34332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T05:18:47.82244Z","caller":"traceutil/trace.go:171","msg":"trace[79226426] transaction","detail":"{read_only:false; response_revision:2224; number_of_response:1; }","duration":"210.367848ms","start":"2026-04-10T05:18:47.611972Z","end":"2026-04-10T05:18:47.82234Z","steps":["trace[79226426] 'process raft request' (duration: 209.94649ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:20:14.016832Z","caller":"traceutil/trace.go:171","msg":"trace[1828285149] transaction","detail":"{read_only:false; response_revision:2877; number_of_response:1; }","duration":"191.349309ms","start":"2026-04-10T05:20:13.825445Z","end":"2026-04-10T05:20:14.016794Z","steps":["trace[1828285149] 'process raft request' (duration: 190.931651ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:22:50.073781Z","caller":"traceutil/trace.go:171","msg":"trace[292103974] transaction","detail":"{read_only:false; response_revision:3904; number_of_response:1; }","duration":"126.052233ms","start":"2026-04-10T05:22:49.947695Z","end":"2026-04-10T05:22:50.073748Z","steps":["trace[292103974] 'process raft request' (duration: 125.851959ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:24:19.950393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.821824ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T05:24:19.950528Z","caller":"traceutil/trace.go:171","msg":"trace[43882490] linearizableReadLoop","detail":"{readStateIndex:5292; appliedIndex:5291; }","duration":"297.881544ms","start":"2026-04-10T05:24:19.652629Z","end":"2026-04-10T05:24:19.950511Z","steps":["trace[43882490] 'read index received' (duration: 62.758604ms)","trace[43882490] 'applied index is now lower than readState.Index' (duration: 235.12151ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T05:24:19.950785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.148499ms","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-10T05:24:19.950827Z","caller":"traceutil/trace.go:171","msg":"trace[1633533531] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5092; }","duration":"298.215521ms","start":"2026-04-10T05:24:19.652601Z","end":"2026-04-10T05:24:19.950817Z","steps":["trace[1633533531] 'agreement among raft nodes before linearized reading' (duration: 298.002616ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:24:19.951029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.072769ms","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-10T05:24:19.950743Z","caller":"traceutil/trace.go:171","msg":"trace[638399617] transaction","detail":"{read_only:false; response_revision:5092; number_of_response:1; }","duration":"301.146728ms","start":"2026-04-10T05:24:19.649446Z","end":"2026-04-10T05:24:19.950593Z","steps":["trace[638399617] 'process raft request' (duration: 65.860895ms)","trace[638399617] 'compare' (duration: 234.545569ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T05:24:19.95112Z","caller":"traceutil/trace.go:171","msg":"trace[1454427291] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5092; }","duration":"178.248342ms","start":"2026-04-10T05:24:19.772853Z","end":"2026-04-10T05:24:19.951101Z","steps":["trace[1454427291] 'agreement among raft nodes before linearized reading' (duration: 177.805413ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:24:19.951282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T05:24:19.64943Z","time spent":"301.72111ms","remote":"127.0.0.1:34332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T05:24:21.796367Z","caller":"traceutil/trace.go:171","msg":"trace[1105385002] transaction","detail":"{read_only:false; response_revision:5125; number_of_response:1; }","duration":"135.459536ms","start":"2026-04-10T05:24:21.660873Z","end":"2026-04-10T05:24:21.796333Z","steps":["trace[1105385002] 'process raft request' (duration: 125.404565ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:24:31.776396Z","caller":"traceutil/trace.go:171","msg":"trace[1652988657] transaction","detail":"{read_only:false; response_revision:5325; number_of_response:1; }","duration":"125.894977ms","start":"2026-04-10T05:24:31.650457Z","end":"2026-04-10T05:24:31.776352Z","steps":["trace[1652988657] 'process raft request' (duration: 71.02021ms)","trace[1652988657] 'compare' (duration: 54.600551ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T05:24:31.776547Z","caller":"traceutil/trace.go:171","msg":"trace[1317457846] transaction","detail":"{read_only:false; response_revision:5326; number_of_response:1; }","duration":"125.503819ms","start":"2026-04-10T05:24:31.651008Z","end":"2026-04-10T05:24:31.776512Z","steps":["trace[1317457846] 'process raft request' (duration: 125.281445ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:24:32.128301Z","caller":"traceutil/trace.go:171","msg":"trace[640513985] transaction","detail":"{read_only:false; response_revision:5337; number_of_response:1; }","duration":"112.106581ms","start":"2026-04-10T05:24:32.016164Z","end":"2026-04-10T05:24:32.128271Z","steps":["trace[640513985] 'process raft request' (duration: 111.5848ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:24:32.246283Z","caller":"traceutil/trace.go:171","msg":"trace[1846205243] transaction","detail":"{read_only:false; response_revision:5339; number_of_response:1; }","duration":"112.169322ms","start":"2026-04-10T05:24:32.134087Z","end":"2026-04-10T05:24:32.246256Z","steps":["trace[1846205243] 'process raft request' (duration: 108.860326ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:25:08.190986Z","caller":"traceutil/trace.go:171","msg":"trace[858597958] linearizableReadLoop","detail":"{readStateIndex:5891; appliedIndex:5890; }","duration":"164.104602ms","start":"2026-04-10T05:25:08.026851Z","end":"2026-04-10T05:25:08.190956Z","steps":["trace[858597958] 'read index received' (duration: 163.901258ms)","trace[858597958] 'applied index is now lower than readState.Index' (duration: 202.324µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T05:25:08.191114Z","caller":"traceutil/trace.go:171","msg":"trace[892718643] transaction","detail":"{read_only:false; response_revision:5672; number_of_response:1; }","duration":"185.301968ms","start":"2026-04-10T05:25:08.005772Z","end":"2026-04-10T05:25:08.191074Z","steps":["trace[892718643] 'process raft request' (duration: 184.996752ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:25:08.191185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.287785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/kube-public/\" range_end:\"/registry/persistentvolumeclaims/kube-public0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T05:25:08.191278Z","caller":"traceutil/trace.go:171","msg":"trace[614932670] range","detail":"{range_begin:/registry/persistentvolumeclaims/kube-public/; range_end:/registry/persistentvolumeclaims/kube-public0; response_count:0; response_revision:5672; }","duration":"164.442769ms","start":"2026-04-10T05:25:08.026816Z","end":"2026-04-10T05:25:08.191258Z","steps":["trace[614932670] 'agreement among raft nodes before linearized reading' (duration: 164.259384ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:25:08.191286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.928269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:1 size:1059"} {"level":"info","ts":"2026-04-10T05:25:08.191327Z","caller":"traceutil/trace.go:171","msg":"trace[355943303] range","detail":"{range_begin:/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:1; response_revision:5672; }","duration":"162.03388ms","start":"2026-04-10T05:25:08.029281Z","end":"2026-04-10T05:25:08.191315Z","steps":["trace[355943303] 'agreement among raft nodes before linearized reading' (duration: 161.857846ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:25:08.191677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.688578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-infra-manager\" ","response":"range_response_count:1 size:1111"} {"level":"info","ts":"2026-04-10T05:25:08.191803Z","caller":"traceutil/trace.go:171","msg":"trace[1021432591] range","detail":"{range_begin:/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-infra-manager; range_end:; response_count:1; response_revision:5672; }","duration":"111.850021ms","start":"2026-04-10T05:25:08.079922Z","end":"2026-04-10T05:25:08.191772Z","steps":["trace[1021432591] 'agreement among raft nodes before linearized reading' (duration: 111.457693ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T05:25:08.191772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.7047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-10T05:25:08.191896Z","caller":"traceutil/trace.go:171","msg":"trace[1268203151] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/; range_end:/registry/nfd.k8s-sigs.io/nodefeatures0; response_count:0; response_revision:5672; }","duration":"134.871764ms","start":"2026-04-10T05:25:08.056993Z","end":"2026-04-10T05:25:08.191864Z","steps":["trace[1268203151] 'agreement among raft nodes before linearized reading' (duration: 134.617419ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T05:25:33.679665Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2988} {"level":"info","ts":"2026-04-10T05:25:33.749874Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2988,"took":"68.783553ms","hash":849621023,"current-db-size-bytes":56627200,"current-db-size":"57 MB","current-db-size-in-use-bytes":32137216,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-10T05:25:33.749933Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":849621023,"revision":2988,"compact-revision":-1}