{"level":"warn","ts":"2026-04-10T18:02:36.983042Z","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-10T18:02:36.983174Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.181:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.181:2380","--initial-cluster=instance=https://199.19.213.181:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.181:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.181: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-10T18:02:36.983265Z","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-10T18:02:36.983283Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.181:2380"]} {"level":"info","ts":"2026-04-10T18:02:36.983306Z","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-10T18:02:36.98407Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.181:2379"]} {"level":"info","ts":"2026-04-10T18:02:36.984172Z","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.19.213.181:2380"],"listen-peer-urls":["https://199.19.213.181:2380"],"advertise-client-urls":["https://199.19.213.181:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.181:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.181: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-10T18:02:36.988324Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.899609ms"} {"level":"info","ts":"2026-04-10T18:02:36.996834Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1a532052a1358225","cluster-id":"b34324311008a1d3"} {"level":"info","ts":"2026-04-10T18:02:36.996948Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 switched to configuration voters=()"} {"level":"info","ts":"2026-04-10T18:02:36.996984Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 became follower at term 0"} {"level":"info","ts":"2026-04-10T18:02:36.99701Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1a532052a1358225 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-10T18:02:36.997024Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 became follower at term 1"} {"level":"info","ts":"2026-04-10T18:02:36.997074Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 switched to configuration voters=(1896895407317156389)"} {"level":"warn","ts":"2026-04-10T18:02:37.006634Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-10T18:02:37.011956Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-10T18:02:37.015555Z","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-10T18:02:37.019896Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1a532052a1358225","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-10T18:02:37.020121Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1a532052a1358225","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-10T18:02:37.020206Z","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-10T18:02:37.021142Z","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-10T18:02:37.021169Z","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-10T18:02:37.022057Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 switched to configuration voters=(1896895407317156389)"} {"level":"info","ts":"2026-04-10T18:02:37.022452Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b34324311008a1d3","local-member-id":"1a532052a1358225","added-peer-id":"1a532052a1358225","added-peer-peer-urls":["https://199.19.213.181:2380"]} {"level":"info","ts":"2026-04-10T18:02:37.025615Z","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-10T18:02:37.025739Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.181:2380"} {"level":"info","ts":"2026-04-10T18:02:37.025781Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.181:2380"} {"level":"info","ts":"2026-04-10T18:02:37.026015Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1a532052a1358225","initial-advertise-peer-urls":["https://199.19.213.181:2380"],"listen-peer-urls":["https://199.19.213.181:2380"],"advertise-client-urls":["https://199.19.213.181:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.181:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-10T18:02:37.026056Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-10T18:02:37.997902Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 is starting a new election at term 1"} {"level":"info","ts":"2026-04-10T18:02:37.997974Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-10T18:02:37.998001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 received MsgPreVoteResp from 1a532052a1358225 at term 1"} {"level":"info","ts":"2026-04-10T18:02:37.998021Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 became candidate at term 2"} {"level":"info","ts":"2026-04-10T18:02:37.998034Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 received MsgVoteResp from 1a532052a1358225 at term 2"} {"level":"info","ts":"2026-04-10T18:02:37.998051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 became leader at term 2"} {"level":"info","ts":"2026-04-10T18:02:37.99807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1a532052a1358225 elected leader 1a532052a1358225 at term 2"} {"level":"info","ts":"2026-04-10T18:02:37.999673Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T18:02:38.001347Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-10T18:02:38.001351Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1a532052a1358225","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.181:2379]}","request-path":"/0/members/1a532052a1358225/attributes","cluster-id":"b34324311008a1d3","publish-timeout":"7s"} {"level":"info","ts":"2026-04-10T18:02:38.001408Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-10T18:02:38.001855Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-10T18:02:38.001991Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-10T18:02:38.002758Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b34324311008a1d3","local-member-id":"1a532052a1358225","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T18:02:38.002966Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T18:02:38.003028Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T18:02:38.004098Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-10T18:02:38.004695Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.181:2379"} {"level":"info","ts":"2026-04-10T18:02:56.021021Z","caller":"traceutil/trace.go:171","msg":"trace[6949257] linearizableReadLoop","detail":"{readStateIndex:428; appliedIndex:427; }","duration":"190.736286ms","start":"2026-04-10T18:02:55.830256Z","end":"2026-04-10T18:02:56.020992Z","steps":["trace[6949257] 'read index received' (duration: 190.48314ms)","trace[6949257] 'applied index is now lower than readState.Index' (duration: 251.766µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:02:56.02111Z","caller":"traceutil/trace.go:171","msg":"trace[2033194051] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"215.932788ms","start":"2026-04-10T18:02:55.805133Z","end":"2026-04-10T18:02:56.021065Z","steps":["trace[2033194051] 'process raft request' (duration: 215.675982ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:02:56.02138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.082033ms","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-10T18:02:56.02156Z","caller":"traceutil/trace.go:171","msg":"trace[144763411] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:417; }","duration":"191.320177ms","start":"2026-04-10T18:02:55.830217Z","end":"2026-04-10T18:02:56.021537Z","steps":["trace[144763411] 'agreement among raft nodes before linearized reading' (duration: 190.98086ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:02:56.136114Z","caller":"traceutil/trace.go:171","msg":"trace[2083154546] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"109.542136ms","start":"2026-04-10T18:02:56.026526Z","end":"2026-04-10T18:02:56.136068Z","steps":["trace[2083154546] 'process raft request' (duration: 88.816924ms)","trace[2083154546] 'compare' (duration: 20.551458ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:02:56.13689Z","caller":"traceutil/trace.go:171","msg":"trace[1314062706] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"100.38048ms","start":"2026-04-10T18:02:56.036485Z","end":"2026-04-10T18:02:56.136866Z","steps":["trace[1314062706] 'process raft request' (duration: 100.130705ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:02:56.48768Z","caller":"traceutil/trace.go:171","msg":"trace[561912260] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"145.724941ms","start":"2026-04-10T18:02:56.341909Z","end":"2026-04-10T18:02:56.487634Z","steps":["trace[561912260] 'process raft request' (duration: 68.661736ms)","trace[561912260] 'compare' (duration: 76.763099ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:02:56.488533Z","caller":"traceutil/trace.go:171","msg":"trace[1098186266] linearizableReadLoop","detail":"{readStateIndex:448; appliedIndex:446; }","duration":"139.460482ms","start":"2026-04-10T18:02:56.349055Z","end":"2026-04-10T18:02:56.488515Z","steps":["trace[1098186266] 'read index received' (duration: 61.53272ms)","trace[1098186266] 'applied index is now lower than readState.Index' (duration: 77.926472ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:02:56.488588Z","caller":"traceutil/trace.go:171","msg":"trace[27956279] transaction","detail":"{read_only:false; response_revision:437; number_of_response:1; }","duration":"144.24661ms","start":"2026-04-10T18:02:56.344305Z","end":"2026-04-10T18:02:56.488551Z","steps":["trace[27956279] 'process raft request' (duration: 144.042536ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:02:56.488649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.348362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-67659f764b\" ","response":"range_response_count:1 size:3855"} {"level":"info","ts":"2026-04-10T18:02:56.488856Z","caller":"traceutil/trace.go:171","msg":"trace[1463397699] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-67659f764b; range_end:; response_count:1; response_revision:437; }","duration":"147.581869ms","start":"2026-04-10T18:02:56.341257Z","end":"2026-04-10T18:02:56.488838Z","steps":["trace[1463397699] 'agreement among raft nodes before linearized reading' (duration: 147.327153ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:02:56.490598Z","caller":"traceutil/trace.go:171","msg":"trace[878547707] transaction","detail":"{read_only:false; response_revision:438; number_of_response:1; }","duration":"132.362388ms","start":"2026-04-10T18:02:56.358218Z","end":"2026-04-10T18:02:56.490581Z","steps":["trace[878547707] 'process raft request' (duration: 132.231066ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:01.497654Z","caller":"traceutil/trace.go:171","msg":"trace[2079819627] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"102.458941ms","start":"2026-04-10T18:03:01.395149Z","end":"2026-04-10T18:03:01.497608Z","steps":["trace[2079819627] 'process raft request' (duration: 97.334297ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:11.38838Z","caller":"traceutil/trace.go:171","msg":"trace[1812306223] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"142.378452ms","start":"2026-04-10T18:03:11.245964Z","end":"2026-04-10T18:03:11.388343Z","steps":["trace[1812306223] 'process raft request' (duration: 140.140986ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:11.388482Z","caller":"traceutil/trace.go:171","msg":"trace[636682378] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"139.36716ms","start":"2026-04-10T18:03:11.249074Z","end":"2026-04-10T18:03:11.388441Z","steps":["trace[636682378] 'process raft request' (duration: 139.175836ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:11.388581Z","caller":"traceutil/trace.go:171","msg":"trace[1787501495] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"139.296539ms","start":"2026-04-10T18:03:11.249249Z","end":"2026-04-10T18:03:11.388546Z","steps":["trace[1787501495] 'process raft request' (duration: 139.055174ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:11.388637Z","caller":"traceutil/trace.go:171","msg":"trace[48708933] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"130.375438ms","start":"2026-04-10T18:03:11.258249Z","end":"2026-04-10T18:03:11.388624Z","steps":["trace[48708933] 'process raft request' (duration: 130.226445ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:11.388658Z","caller":"traceutil/trace.go:171","msg":"trace[1371476730] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"130.614323ms","start":"2026-04-10T18:03:11.257989Z","end":"2026-04-10T18:03:11.388603Z","steps":["trace[1371476730] 'process raft request' (duration: 130.42397ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:11.388735Z","caller":"traceutil/trace.go:171","msg":"trace[900525164] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"130.401178ms","start":"2026-04-10T18:03:11.258305Z","end":"2026-04-10T18:03:11.388706Z","steps":["trace[900525164] 'process raft request' (duration: 130.233725ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:11.388856Z","caller":"traceutil/trace.go:171","msg":"trace[1531796004] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"130.285507ms","start":"2026-04-10T18:03:11.258489Z","end":"2026-04-10T18:03:11.388774Z","steps":["trace[1531796004] 'process raft request' (duration: 130.152704ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:11.388934Z","caller":"traceutil/trace.go:171","msg":"trace[840028934] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"129.801327ms","start":"2026-04-10T18:03:11.259084Z","end":"2026-04-10T18:03:11.388885Z","steps":["trace[840028934] 'process raft request' (duration: 129.621043ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:17.800538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.886692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-10T18:03:17.800628Z","caller":"traceutil/trace.go:171","msg":"trace[1050710983] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:624; }","duration":"206.034455ms","start":"2026-04-10T18:03:17.594577Z","end":"2026-04-10T18:03:17.800611Z","steps":["trace[1050710983] 'range keys from in-memory index tree' (duration: 205.689888ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:17.800653Z","caller":"traceutil/trace.go:171","msg":"trace[449312897] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"189.205303ms","start":"2026-04-10T18:03:17.611421Z","end":"2026-04-10T18:03:17.800627Z","steps":["trace[449312897] 'process raft request' (duration: 125.017299ms)","trace[449312897] 'compare' (duration: 63.924319ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T18:03:18.036113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.815906ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T18:03:18.036236Z","caller":"traceutil/trace.go:171","msg":"trace[1628011290] linearizableReadLoop","detail":"{readStateIndex:645; appliedIndex:644; }","duration":"220.251924ms","start":"2026-04-10T18:03:17.815968Z","end":"2026-04-10T18:03:18.03622Z","steps":["trace[1628011290] 'read index received' (duration: 93.673353ms)","trace[1628011290] 'applied index is now lower than readState.Index' (duration: 126.577291ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T18:03:18.036331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.362416ms","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-10T18:03:18.036354Z","caller":"traceutil/trace.go:171","msg":"trace[1650631360] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:626; }","duration":"220.416447ms","start":"2026-04-10T18:03:17.815928Z","end":"2026-04-10T18:03:18.036345Z","steps":["trace[1650631360] 'agreement among raft nodes before linearized reading' (duration: 220.372586ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:18.036318Z","caller":"traceutil/trace.go:171","msg":"trace[75501823] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"230.92681ms","start":"2026-04-10T18:03:17.805351Z","end":"2026-04-10T18:03:18.036277Z","steps":["trace[75501823] 'process raft request' (duration: 104.39402ms)","trace[75501823] 'compare' (duration: 125.637242ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T18:03:18.036511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.808933ms","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-10T18:03:18.036616Z","caller":"traceutil/trace.go:171","msg":"trace[676361827] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:626; }","duration":"214.986106ms","start":"2026-04-10T18:03:17.821607Z","end":"2026-04-10T18:03:18.036593Z","steps":["trace[676361827] 'agreement among raft nodes before linearized reading' (duration: 214.768132ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:18.036555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.514692ms","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":"info","ts":"2026-04-10T18:03:18.036721Z","caller":"traceutil/trace.go:171","msg":"trace[1094272967] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:626; }","duration":"162.728095ms","start":"2026-04-10T18:03:17.873974Z","end":"2026-04-10T18:03:18.036702Z","steps":["trace[1094272967] 'agreement among raft nodes before linearized reading' (duration: 162.507251ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:18.03678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.408325ms","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-10T18:03:18.036833Z","caller":"traceutil/trace.go:171","msg":"trace[1602964964] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:626; }","duration":"214.480188ms","start":"2026-04-10T18:03:17.822336Z","end":"2026-04-10T18:03:18.036816Z","steps":["trace[1602964964] 'agreement among raft nodes before linearized reading' (duration: 214.396745ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:18.0369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.52362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T18:03:18.036874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.158473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T18:03:18.036905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.588319ms","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":"warn","ts":"2026-04-10T18:03:18.036982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.761027ms","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":"info","ts":"2026-04-10T18:03:18.037Z","caller":"traceutil/trace.go:171","msg":"trace[544159508] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:626; }","duration":"214.709722ms","start":"2026-04-10T18:03:17.82228Z","end":"2026-04-10T18:03:18.03699Z","steps":["trace[544159508] 'agreement among raft nodes before linearized reading' (duration: 214.5882ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:18.037016Z","caller":"traceutil/trace.go:171","msg":"trace[1085780883] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:626; }","duration":"162.855109ms","start":"2026-04-10T18:03:17.87415Z","end":"2026-04-10T18:03:18.037005Z","steps":["trace[1085780883] 'agreement among raft nodes before linearized reading' (duration: 162.791698ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:18.037022Z","caller":"traceutil/trace.go:171","msg":"trace[1573169819] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:626; }","duration":"190.365817ms","start":"2026-04-10T18:03:17.846625Z","end":"2026-04-10T18:03:18.036991Z","steps":["trace[1573169819] 'agreement among raft nodes before linearized reading' (duration: 190.07052ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:18.036703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.938648ms","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-10T18:03:18.03696Z","caller":"traceutil/trace.go:171","msg":"trace[1302288409] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:626; }","duration":"189.584651ms","start":"2026-04-10T18:03:17.847351Z","end":"2026-04-10T18:03:18.036936Z","steps":["trace[1302288409] 'agreement among raft nodes before linearized reading' (duration: 189.52646ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:18.037106Z","caller":"traceutil/trace.go:171","msg":"trace[742832801] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:626; }","duration":"162.427259ms","start":"2026-04-10T18:03:17.874666Z","end":"2026-04-10T18:03:18.037093Z","steps":["trace[742832801] 'agreement among raft nodes before linearized reading' (duration: 161.926338ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:18.037118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.426628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T18:03:18.037162Z","caller":"traceutil/trace.go:171","msg":"trace[1734420001] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:626; }","duration":"190.498019ms","start":"2026-04-10T18:03:17.846651Z","end":"2026-04-10T18:03:18.037149Z","steps":["trace[1734420001] 'agreement among raft nodes before linearized reading' (duration: 190.431238ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:18.237638Z","caller":"traceutil/trace.go:171","msg":"trace[1421545249] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"177.528846ms","start":"2026-04-10T18:03:18.060075Z","end":"2026-04-10T18:03:18.237604Z","steps":["trace[1421545249] 'process raft request' (duration: 163.113933ms)","trace[1421545249] 'compare' (duration: 14.214919ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:03:18.645211Z","caller":"traceutil/trace.go:171","msg":"trace[2077623679] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:648; }","duration":"321.147765ms","start":"2026-04-10T18:03:18.324034Z","end":"2026-04-10T18:03:18.645181Z","steps":["trace[2077623679] 'read index received' (duration: 303.185199ms)","trace[2077623679] 'applied index is now lower than readState.Index' (duration: 17.961556ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:03:18.645266Z","caller":"traceutil/trace.go:171","msg":"trace[893707861] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"327.86832ms","start":"2026-04-10T18:03:18.317353Z","end":"2026-04-10T18:03:18.645221Z","steps":["trace[893707861] 'process raft request' (duration: 309.765192ms)","trace[893707861] 'compare' (duration: 17.927205ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T18:03:18.645448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.321488ms","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-10T18:03:18.645478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:03:18.317332Z","time spent":"328.031273ms","remote":"127.0.0.1:50706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T18:03:18.645555Z","caller":"traceutil/trace.go:171","msg":"trace[880260310] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:630; }","duration":"321.486691ms","start":"2026-04-10T18:03:18.323998Z","end":"2026-04-10T18:03:18.645484Z","steps":["trace[880260310] 'agreement among raft nodes before linearized reading' (duration: 321.319807ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:18.645611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:03:18.323979Z","time spent":"321.617344ms","remote":"127.0.0.1:36656","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":"info","ts":"2026-04-10T18:03:18.900598Z","caller":"traceutil/trace.go:171","msg":"trace[1667486670] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:649; }","duration":"255.284235ms","start":"2026-04-10T18:03:18.645287Z","end":"2026-04-10T18:03:18.900571Z","steps":["trace[1667486670] 'read index received' (duration: 254.203952ms)","trace[1667486670] 'applied index is now lower than readState.Index' (duration: 1.079123ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T18:03:18.900692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.834949ms","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":"info","ts":"2026-04-10T18:03:18.900752Z","caller":"traceutil/trace.go:171","msg":"trace[428537203] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:631; }","duration":"453.92713ms","start":"2026-04-10T18:03:18.446812Z","end":"2026-04-10T18:03:18.900739Z","steps":["trace[428537203] 'agreement among raft nodes before linearized reading' (duration: 453.776737ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:18.90075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.163964ms","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":"warn","ts":"2026-04-10T18:03:18.900806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.794268ms","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":"warn","ts":"2026-04-10T18:03:18.900865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.649631ms","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-10T18:03:18.900858Z","caller":"traceutil/trace.go:171","msg":"trace[62942409] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:631; }","duration":"387.294556ms","start":"2026-04-10T18:03:18.513546Z","end":"2026-04-10T18:03:18.90084Z","steps":["trace[62942409] 'agreement among raft nodes before linearized reading' (duration: 387.119383ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:18.900892Z","caller":"traceutil/trace.go:171","msg":"trace[1049549083] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:631; }","duration":"454.933681ms","start":"2026-04-10T18:03:18.44594Z","end":"2026-04-10T18:03:18.900874Z","steps":["trace[1049549083] 'agreement among raft nodes before linearized reading' (duration: 454.801968ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:18.90091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:03:18.513515Z","time spent":"387.386519ms","remote":"127.0.0.1:36690","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-10T18:03:18.90094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.277633ms","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":"warn","ts":"2026-04-10T18:03:18.900933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.329268ms","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-10T18:03:18.901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.072773ms","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-10T18:03:18.901008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.390086ms","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-10T18:03:18.901042Z","caller":"traceutil/trace.go:171","msg":"trace[263916365] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:631; }","duration":"409.449947ms","start":"2026-04-10T18:03:18.491584Z","end":"2026-04-10T18:03:18.901034Z","steps":["trace[263916365] 'agreement among raft nodes before linearized reading' (duration: 409.402556ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:18.90104Z","caller":"traceutil/trace.go:171","msg":"trace[1105692290] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:631; }","duration":"388.442851ms","start":"2026-04-10T18:03:18.512568Z","end":"2026-04-10T18:03:18.901011Z","steps":["trace[1105692290] 'agreement among raft nodes before linearized reading' (duration: 388.326319ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:18.901072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:03:18.491542Z","time spent":"409.520578ms","remote":"127.0.0.1:36686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-10T18:03:18.900796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:03:18.4468Z","time spent":"453.988011ms","remote":"127.0.0.1:36682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-10T18:03:18.901108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:03:18.512549Z","time spent":"388.543123ms","remote":"127.0.0.1:36690","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-10T18:03:18.901158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.619285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T18:03:18.901195Z","caller":"traceutil/trace.go:171","msg":"trace[1157886713] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:631; }","duration":"483.693995ms","start":"2026-04-10T18:03:18.41749Z","end":"2026-04-10T18:03:18.901184Z","steps":["trace[1157886713] 'agreement among raft nodes before linearized reading' (duration: 483.644664ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:18.900944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:03:18.445918Z","time spent":"455.014522ms","remote":"127.0.0.1:36682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-10T18:03:18.901237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.403732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T18:03:18.900898Z","caller":"traceutil/trace.go:171","msg":"trace[13403146] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:631; }","duration":"408.717302ms","start":"2026-04-10T18:03:18.492171Z","end":"2026-04-10T18:03:18.900888Z","steps":["trace[13403146] 'agreement among raft nodes before linearized reading' (duration: 408.668761ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:18.901038Z","caller":"traceutil/trace.go:171","msg":"trace[1392233963] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:631; }","duration":"455.126574ms","start":"2026-04-10T18:03:18.445903Z","end":"2026-04-10T18:03:18.901029Z","steps":["trace[1392233963] 'agreement among raft nodes before linearized reading' (duration: 455.071753ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:18.901295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.088111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T18:03:18.901308Z","caller":"traceutil/trace.go:171","msg":"trace[651418036] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"445.244965ms","start":"2026-04-10T18:03:18.456053Z","end":"2026-04-10T18:03:18.901298Z","steps":["trace[651418036] 'process raft request' (duration: 443.794266ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:18.90123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:03:18.417469Z","time spent":"483.753417ms","remote":"127.0.0.1:36672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"info","ts":"2026-04-10T18:03:18.901329Z","caller":"traceutil/trace.go:171","msg":"trace[1918269108] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:631; }","duration":"255.156333ms","start":"2026-04-10T18:03:18.646162Z","end":"2026-04-10T18:03:18.901319Z","steps":["trace[1918269108] 'agreement among raft nodes before linearized reading' (duration: 255.103522ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:18.900971Z","caller":"traceutil/trace.go:171","msg":"trace[1644778703] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:631; }","duration":"409.342205ms","start":"2026-04-10T18:03:18.491622Z","end":"2026-04-10T18:03:18.900964Z","steps":["trace[1644778703] 'agreement among raft nodes before linearized reading' (duration: 409.293294ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:18.901266Z","caller":"traceutil/trace.go:171","msg":"trace[653347101] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:631; }","duration":"524.498884ms","start":"2026-04-10T18:03:18.376759Z","end":"2026-04-10T18:03:18.901258Z","steps":["trace[653347101] 'agreement among raft nodes before linearized reading' (duration: 524.452023ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:18.901406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:03:18.45602Z","time spent":"445.322186ms","remote":"127.0.0.1:50522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T18:03:18.901433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:03:18.376709Z","time spent":"524.713488ms","remote":"127.0.0.1:36660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-04-10T18:03:18.901391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.072842ms","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":"warn","ts":"2026-04-10T18:03:18.901425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:03:18.492146Z","time spent":"409.188261ms","remote":"127.0.0.1:36686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-10T18:03:18.90146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:03:18.491598Z","time spent":"409.818994ms","remote":"127.0.0.1:36686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-10T18:03:18.901076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.701835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T18:03:18.901636Z","caller":"traceutil/trace.go:171","msg":"trace[1006024581] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:631; }","duration":"483.266957ms","start":"2026-04-10T18:03:18.418328Z","end":"2026-04-10T18:03:18.901595Z","steps":["trace[1006024581] 'agreement among raft nodes before linearized reading' (duration: 482.728036ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:18.901735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:03:18.418314Z","time spent":"483.395389ms","remote":"127.0.0.1:36660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 "} {"level":"warn","ts":"2026-04-10T18:03:18.901734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.168667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T18:03:18.901748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.869172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T18:03:18.901818Z","caller":"traceutil/trace.go:171","msg":"trace[325840456] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:631; }","duration":"206.965404ms","start":"2026-04-10T18:03:18.694825Z","end":"2026-04-10T18:03:18.901791Z","steps":["trace[325840456] 'agreement among raft nodes before linearized reading' (duration: 206.847652ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:18.901829Z","caller":"traceutil/trace.go:171","msg":"trace[1577413443] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:631; }","duration":"206.250918ms","start":"2026-04-10T18:03:18.695533Z","end":"2026-04-10T18:03:18.901784Z","steps":["trace[1577413443] 'agreement among raft nodes before linearized reading' (duration: 206.115896ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:18.901117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.522852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T18:03:18.901904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.635737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T18:03:18.901867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.413558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T18:03:18.901977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.008143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T18:03:18.901963Z","caller":"traceutil/trace.go:171","msg":"trace[203567370] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:631; }","duration":"484.383469ms","start":"2026-04-10T18:03:18.417546Z","end":"2026-04-10T18:03:18.90193Z","steps":["trace[203567370] 'agreement among raft nodes before linearized reading' (duration: 483.549603ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:18.90199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.641362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T18:03:18.902001Z","caller":"traceutil/trace.go:171","msg":"trace[968822114] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:631; }","duration":"138.063885ms","start":"2026-04-10T18:03:18.763929Z","end":"2026-04-10T18:03:18.901993Z","steps":["trace[968822114] 'agreement among raft nodes before linearized reading' (duration: 138.028784ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:18.902027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:03:18.417517Z","time spent":"484.491272ms","remote":"127.0.0.1:36672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-10T18:03:18.902044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.306509ms","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-10T18:03:18.902053Z","caller":"traceutil/trace.go:171","msg":"trace[237927612] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:631; }","duration":"255.701574ms","start":"2026-04-10T18:03:18.646323Z","end":"2026-04-10T18:03:18.902025Z","steps":["trace[237927612] 'agreement among raft nodes before linearized reading' (duration: 255.642073ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:18.902102Z","caller":"traceutil/trace.go:171","msg":"trace[701921796] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:631; }","duration":"173.414382ms","start":"2026-04-10T18:03:18.728671Z","end":"2026-04-10T18:03:18.902086Z","steps":["trace[701921796] 'agreement among raft nodes before linearized reading' (duration: 173.31083ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:18.900775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.159615ms","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-10T18:03:18.902132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.485683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T18:03:18.902199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.572855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T18:03:18.902234Z","caller":"traceutil/trace.go:171","msg":"trace[526189882] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:631; }","duration":"173.636677ms","start":"2026-04-10T18:03:18.728588Z","end":"2026-04-10T18:03:18.902224Z","steps":["trace[526189882] 'agreement among raft nodes before linearized reading' (duration: 173.578726ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:18.902238Z","caller":"traceutil/trace.go:171","msg":"trace[840326141] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:631; }","duration":"577.238885ms","start":"2026-04-10T18:03:18.32424Z","end":"2026-04-10T18:03:18.901478Z","steps":["trace[840326141] 'agreement among raft nodes before linearized reading' (duration: 576.97006ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:18.902356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:03:18.324234Z","time spent":"578.104213ms","remote":"127.0.0.1:36656","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-10T18:03:18.901941Z","caller":"traceutil/trace.go:171","msg":"trace[854198090] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:631; }","duration":"172.685377ms","start":"2026-04-10T18:03:18.729244Z","end":"2026-04-10T18:03:18.901929Z","steps":["trace[854198090] 'agreement among raft nodes before linearized reading' (duration: 172.635416ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:18.901314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:03:18.445893Z","time spent":"455.412341ms","remote":"127.0.0.1:36682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"info","ts":"2026-04-10T18:03:18.902236Z","caller":"traceutil/trace.go:171","msg":"trace[530173057] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:631; }","duration":"525.632547ms","start":"2026-04-10T18:03:18.376567Z","end":"2026-04-10T18:03:18.9022Z","steps":["trace[530173057] 'agreement among raft nodes before linearized reading' (duration: 525.500334ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:18.902602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:03:18.376551Z","time spent":"526.021715ms","remote":"127.0.0.1:36660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-04-10T18:03:18.90205Z","caller":"traceutil/trace.go:171","msg":"trace[2000790548] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:631; }","duration":"255.630883ms","start":"2026-04-10T18:03:18.646362Z","end":"2026-04-10T18:03:18.901993Z","steps":["trace[2000790548] 'agreement among raft nodes before linearized reading' (duration: 255.397068ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:18.901912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.976214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T18:03:18.902781Z","caller":"traceutil/trace.go:171","msg":"trace[536735453] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:631; }","duration":"207.922384ms","start":"2026-04-10T18:03:18.694843Z","end":"2026-04-10T18:03:18.902765Z","steps":["trace[536735453] 'agreement among raft nodes before linearized reading' (duration: 206.897652ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:18.902223Z","caller":"traceutil/trace.go:171","msg":"trace[1096202549] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:631; }","duration":"389.658526ms","start":"2026-04-10T18:03:18.512533Z","end":"2026-04-10T18:03:18.902192Z","steps":["trace[1096202549] 'agreement among raft nodes before linearized reading' (duration: 388.098794ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:18.903017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:03:18.512518Z","time spent":"390.388551ms","remote":"127.0.0.1:36690","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":"info","ts":"2026-04-10T18:03:20.307182Z","caller":"traceutil/trace.go:171","msg":"trace[1035935901] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"193.357157ms","start":"2026-04-10T18:03:20.113776Z","end":"2026-04-10T18:03:20.307133Z","steps":["trace[1035935901] 'process raft request' (duration: 192.914948ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:34.587047Z","caller":"traceutil/trace.go:171","msg":"trace[2098833436] linearizableReadLoop","detail":"{readStateIndex:810; appliedIndex:809; }","duration":"464.681998ms","start":"2026-04-10T18:03:34.122336Z","end":"2026-04-10T18:03:34.587018Z","steps":["trace[2098833436] 'read index received' (duration: 464.475844ms)","trace[2098833436] 'applied index is now lower than readState.Index' (duration: 205.024µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:03:34.587173Z","caller":"traceutil/trace.go:171","msg":"trace[2090146206] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"521.073735ms","start":"2026-04-10T18:03:34.066059Z","end":"2026-04-10T18:03:34.587133Z","steps":["trace[2090146206] 'process raft request' (duration: 520.753818ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:34.58736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:03:34.066029Z","time spent":"521.229388ms","remote":"127.0.0.1:50610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4025,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T18:03:34.587363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.380578ms","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-10T18:03:34.587419Z","caller":"traceutil/trace.go:171","msg":"trace[2109955221] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:787; }","duration":"189.50537ms","start":"2026-04-10T18:03:34.397901Z","end":"2026-04-10T18:03:34.587406Z","steps":["trace[2109955221] 'agreement among raft nodes before linearized reading' (duration: 189.303995ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:34.587391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.022626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-10T18:03:34.58749Z","caller":"traceutil/trace.go:171","msg":"trace[1066781566] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:787; }","duration":"465.182899ms","start":"2026-04-10T18:03:34.122277Z","end":"2026-04-10T18:03:34.58746Z","steps":["trace[1066781566] 'agreement among raft nodes before linearized reading' (duration: 464.896193ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:03:34.587549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:03:34.122243Z","time spent":"465.294211ms","remote":"127.0.0.1:50706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-10T18:03:34.587623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.68141ms","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":"warn","ts":"2026-04-10T18:03:34.587739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.241913ms","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-10T18:03:34.587792Z","caller":"traceutil/trace.go:171","msg":"trace[811315916] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:787; }","duration":"175.915304ms","start":"2026-04-10T18:03:34.411838Z","end":"2026-04-10T18:03:34.587753Z","steps":["trace[811315916] 'agreement among raft nodes before linearized reading' (duration: 175.467655ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:03:34.587846Z","caller":"traceutil/trace.go:171","msg":"trace[2138039480] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:787; }","duration":"185.394827ms","start":"2026-04-10T18:03:34.402428Z","end":"2026-04-10T18:03:34.587823Z","steps":["trace[2138039480] 'agreement among raft nodes before linearized reading' (duration: 184.981898ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:04:05.500985Z","caller":"traceutil/trace.go:171","msg":"trace[1049637843] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1198; }","duration":"127.752111ms","start":"2026-04-10T18:04:05.373201Z","end":"2026-04-10T18:04:05.500953Z","steps":["trace[1049637843] 'process raft request' (duration: 126.598748ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:04:23.905983Z","caller":"traceutil/trace.go:171","msg":"trace[1741310880] transaction","detail":"{read_only:false; response_revision:1436; number_of_response:1; }","duration":"105.030507ms","start":"2026-04-10T18:04:23.80091Z","end":"2026-04-10T18:04:23.905941Z","steps":["trace[1741310880] 'process raft request' (duration: 65.885356ms)","trace[1741310880] 'compare' (duration: 38.982408ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:04:25.550317Z","caller":"traceutil/trace.go:171","msg":"trace[354780830] transaction","detail":"{read_only:false; response_revision:1447; number_of_response:1; }","duration":"105.953025ms","start":"2026-04-10T18:04:25.444339Z","end":"2026-04-10T18:04:25.550292Z","steps":["trace[354780830] 'process raft request' (duration: 105.778702ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:04:50.869082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.11816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T18:04:50.869183Z","caller":"traceutil/trace.go:171","msg":"trace[756141929] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1846; }","duration":"102.258692ms","start":"2026-04-10T18:04:50.766904Z","end":"2026-04-10T18:04:50.869163Z","steps":["trace[756141929] 'range keys from in-memory index tree' (duration: 101.956776ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:05:34.867714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.006582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T18:05:34.867824Z","caller":"traceutil/trace.go:171","msg":"trace[500003852] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2143; }","duration":"101.193376ms","start":"2026-04-10T18:05:34.766608Z","end":"2026-04-10T18:05:34.867802Z","steps":["trace[500003852] 'range keys from in-memory index tree' (duration: 100.817858ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:07:03.868327Z","caller":"traceutil/trace.go:171","msg":"trace[242666360] transaction","detail":"{read_only:false; response_revision:2815; number_of_response:1; }","duration":"137.080154ms","start":"2026-04-10T18:07:03.731218Z","end":"2026-04-10T18:07:03.868298Z","steps":["trace[242666360] 'process raft request' (duration: 136.923801ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:07:03.880625Z","caller":"traceutil/trace.go:171","msg":"trace[359161184] linearizableReadLoop","detail":"{readStateIndex:2921; appliedIndex:2919; }","duration":"114.632856ms","start":"2026-04-10T18:07:03.765932Z","end":"2026-04-10T18:07:03.880565Z","steps":["trace[359161184] 'read index received' (duration: 102.3143ms)","trace[359161184] 'applied index is now lower than readState.Index' (duration: 12.317436ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:07:03.880718Z","caller":"traceutil/trace.go:171","msg":"trace[320028815] transaction","detail":"{read_only:false; response_revision:2816; number_of_response:1; }","duration":"147.730447ms","start":"2026-04-10T18:07:03.732963Z","end":"2026-04-10T18:07:03.880694Z","steps":["trace[320028815] 'process raft request' (duration: 147.481092ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:07:03.880895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.924662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T18:07:03.881023Z","caller":"traceutil/trace.go:171","msg":"trace[1896245180] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2816; }","duration":"115.110986ms","start":"2026-04-10T18:07:03.765888Z","end":"2026-04-10T18:07:03.880999Z","steps":["trace[1896245180] 'agreement among raft nodes before linearized reading' (duration: 114.867311ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:07:04.068463Z","caller":"traceutil/trace.go:171","msg":"trace[653890130] transaction","detail":"{read_only:false; response_revision:2817; number_of_response:1; }","duration":"182.889519ms","start":"2026-04-10T18:07:03.885527Z","end":"2026-04-10T18:07:04.068417Z","steps":["trace[653890130] 'process raft request' (duration: 127.125527ms)","trace[653890130] 'compare' (duration: 55.559718ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:07:04.111062Z","caller":"traceutil/trace.go:171","msg":"trace[779967254] linearizableReadLoop","detail":"{readStateIndex:2924; appliedIndex:2921; }","duration":"154.039073ms","start":"2026-04-10T18:07:03.956983Z","end":"2026-04-10T18:07:04.111022Z","steps":["trace[779967254] 'read index received' (duration: 55.692841ms)","trace[779967254] 'applied index is now lower than readState.Index' (duration: 98.344312ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:07:04.111135Z","caller":"traceutil/trace.go:171","msg":"trace[1179435330] transaction","detail":"{read_only:false; response_revision:2819; number_of_response:1; }","duration":"224.999909ms","start":"2026-04-10T18:07:03.886106Z","end":"2026-04-10T18:07:04.111105Z","steps":["trace[1179435330] 'process raft request' (duration: 224.857686ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:07:04.111403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.38948ms","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-10T18:07:04.111483Z","caller":"traceutil/trace.go:171","msg":"trace[366575353] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2819; }","duration":"154.544183ms","start":"2026-04-10T18:07:03.956916Z","end":"2026-04-10T18:07:04.111461Z","steps":["trace[366575353] 'agreement among raft nodes before linearized reading' (duration: 154.263807ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:07:04.111539Z","caller":"traceutil/trace.go:171","msg":"trace[1393892260] transaction","detail":"{read_only:false; response_revision:2818; number_of_response:1; }","duration":"225.515098ms","start":"2026-04-10T18:07:03.885976Z","end":"2026-04-10T18:07:04.111491Z","steps":["trace[1393892260] 'process raft request' (duration: 224.803854ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:10:45.104952Z","caller":"traceutil/trace.go:171","msg":"trace[672401136] transaction","detail":"{read_only:false; response_revision:4268; number_of_response:1; }","duration":"116.865678ms","start":"2026-04-10T18:10:44.988059Z","end":"2026-04-10T18:10:45.104925Z","steps":["trace[672401136] 'process raft request' (duration: 94.026661ms)","trace[672401136] 'compare' (duration: 22.697884ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:11:08.623941Z","caller":"traceutil/trace.go:171","msg":"trace[1678230142] transaction","detail":"{read_only:false; response_revision:5064; number_of_response:1; }","duration":"113.584412ms","start":"2026-04-10T18:11:08.510331Z","end":"2026-04-10T18:11:08.623916Z","steps":["trace[1678230142] 'process raft request' (duration: 113.418519ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:18.863372Z","caller":"traceutil/trace.go:171","msg":"trace[317229771] transaction","detail":"{read_only:false; response_revision:5266; number_of_response:1; }","duration":"127.549692ms","start":"2026-04-10T18:11:18.735798Z","end":"2026-04-10T18:11:18.863348Z","steps":["trace[317229771] 'process raft request' (duration: 127.44249ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:18.863407Z","caller":"traceutil/trace.go:171","msg":"trace[1680761037] transaction","detail":"{read_only:false; response_revision:5265; number_of_response:1; }","duration":"128.667904ms","start":"2026-04-10T18:11:18.734702Z","end":"2026-04-10T18:11:18.86337Z","steps":["trace[1680761037] 'process raft request' (duration: 128.403507ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:18.864049Z","caller":"traceutil/trace.go:171","msg":"trace[2075911275] transaction","detail":"{read_only:false; response_revision:5267; number_of_response:1; }","duration":"127.95459ms","start":"2026-04-10T18:11:18.736034Z","end":"2026-04-10T18:11:18.863989Z","steps":["trace[2075911275] 'process raft request' (duration: 127.247926ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:26.926478Z","caller":"traceutil/trace.go:171","msg":"trace[563550733] transaction","detail":"{read_only:false; response_revision:5407; number_of_response:1; }","duration":"154.693944ms","start":"2026-04-10T18:11:26.771762Z","end":"2026-04-10T18:11:26.926456Z","steps":["trace[563550733] 'process raft request' (duration: 154.555941ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:27.441114Z","caller":"traceutil/trace.go:171","msg":"trace[201175240] transaction","detail":"{read_only:false; response_revision:5408; number_of_response:1; }","duration":"163.260686ms","start":"2026-04-10T18:11:27.277825Z","end":"2026-04-10T18:11:27.441086Z","steps":["trace[201175240] 'process raft request' (duration: 163.085882ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:27.491218Z","caller":"traceutil/trace.go:171","msg":"trace[1802268203] transaction","detail":"{read_only:false; response_revision:5409; number_of_response:1; }","duration":"200.98998ms","start":"2026-04-10T18:11:27.290203Z","end":"2026-04-10T18:11:27.491193Z","steps":["trace[1802268203] 'process raft request' (duration: 182.684424ms)","trace[1802268203] 'compare' (duration: 18.156383ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:11:27.491426Z","caller":"traceutil/trace.go:171","msg":"trace[1163770934] linearizableReadLoop","detail":"{readStateIndex:5608; appliedIndex:5605; }","duration":"164.137324ms","start":"2026-04-10T18:11:27.327262Z","end":"2026-04-10T18:11:27.491399Z","steps":["trace[1163770934] 'read index received' (duration: 113.649363ms)","trace[1163770934] 'applied index is now lower than readState.Index' (duration: 50.486571ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:11:27.491725Z","caller":"traceutil/trace.go:171","msg":"trace[800538788] transaction","detail":"{read_only:false; response_revision:5410; number_of_response:1; }","duration":"197.611423ms","start":"2026-04-10T18:11:27.294101Z","end":"2026-04-10T18:11:27.491712Z","steps":["trace[800538788] 'process raft request' (duration: 197.054421ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:11:27.492031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.762966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"warn","ts":"2026-04-10T18:11:27.492024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.894109ms","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-10T18:11:27.492067Z","caller":"traceutil/trace.go:171","msg":"trace[891725378] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5410; }","duration":"164.844608ms","start":"2026-04-10T18:11:27.327213Z","end":"2026-04-10T18:11:27.492058Z","steps":["trace[891725378] 'agreement among raft nodes before linearized reading' (duration: 164.724056ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:27.492103Z","caller":"traceutil/trace.go:171","msg":"trace[1346226458] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5410; }","duration":"101.028991ms","start":"2026-04-10T18:11:27.391055Z","end":"2026-04-10T18:11:27.492084Z","steps":["trace[1346226458] 'agreement among raft nodes before linearized reading' (duration: 100.800237ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:28.915024Z","caller":"traceutil/trace.go:171","msg":"trace[447836879] transaction","detail":"{read_only:false; response_revision:5453; number_of_response:1; }","duration":"105.805697ms","start":"2026-04-10T18:11:28.809198Z","end":"2026-04-10T18:11:28.915004Z","steps":["trace[447836879] 'process raft request' (duration: 105.682944ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:28.924682Z","caller":"traceutil/trace.go:171","msg":"trace[1170269982] transaction","detail":"{read_only:false; response_revision:5454; number_of_response:1; }","duration":"114.805416ms","start":"2026-04-10T18:11:28.809858Z","end":"2026-04-10T18:11:28.924664Z","steps":["trace[1170269982] 'process raft request' (duration: 114.584262ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:28.925135Z","caller":"traceutil/trace.go:171","msg":"trace[1384102857] transaction","detail":"{read_only:false; response_revision:5455; number_of_response:1; }","duration":"113.376657ms","start":"2026-04-10T18:11:28.811736Z","end":"2026-04-10T18:11:28.925112Z","steps":["trace[1384102857] 'process raft request' (duration: 112.852607ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:28.925246Z","caller":"traceutil/trace.go:171","msg":"trace[526186544] transaction","detail":"{read_only:false; response_revision:5456; number_of_response:1; }","duration":"113.330696ms","start":"2026-04-10T18:11:28.811902Z","end":"2026-04-10T18:11:28.925233Z","steps":["trace[526186544] 'process raft request' (duration: 112.935549ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:43.109234Z","caller":"traceutil/trace.go:171","msg":"trace[624848724] transaction","detail":"{read_only:false; response_revision:5633; number_of_response:1; }","duration":"103.680171ms","start":"2026-04-10T18:11:43.005536Z","end":"2026-04-10T18:11:43.109216Z","steps":["trace[624848724] 'process raft request' (duration: 103.396525ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:43.109259Z","caller":"traceutil/trace.go:171","msg":"trace[245489513] transaction","detail":"{read_only:false; response_revision:5632; number_of_response:1; }","duration":"104.158102ms","start":"2026-04-10T18:11:43.005074Z","end":"2026-04-10T18:11:43.109232Z","steps":["trace[245489513] 'process raft request' (duration: 103.830124ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:11:43.109268Z","caller":"traceutil/trace.go:171","msg":"trace[18434449] transaction","detail":"{read_only:false; response_revision:5631; number_of_response:1; }","duration":"104.360466ms","start":"2026-04-10T18:11:43.004865Z","end":"2026-04-10T18:11:43.109226Z","steps":["trace[18434449] 'process raft request' (duration: 84.636052ms)","trace[18434449] 'compare' (duration: 19.257853ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:11:43.109314Z","caller":"traceutil/trace.go:171","msg":"trace[98130942] transaction","detail":"{read_only:false; response_revision:5634; number_of_response:1; }","duration":"103.420187ms","start":"2026-04-10T18:11:43.005862Z","end":"2026-04-10T18:11:43.109282Z","steps":["trace[98130942] 'process raft request' (duration: 103.10717ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:12:38.03681Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3002} {"level":"info","ts":"2026-04-10T18:12:38.12312Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3002,"took":"84.525133ms","hash":2431321856,"current-db-size-bytes":57683968,"current-db-size":"58 MB","current-db-size-in-use-bytes":31076352,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-10T18:12:38.123218Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2431321856,"revision":3002,"compact-revision":-1} {"level":"info","ts":"2026-04-10T18:13:40.519457Z","caller":"traceutil/trace.go:171","msg":"trace[1574813959] linearizableReadLoop","detail":"{readStateIndex:6740; appliedIndex:6739; }","duration":"213.866943ms","start":"2026-04-10T18:13:40.305563Z","end":"2026-04-10T18:13:40.51943Z","steps":["trace[1574813959] 'read index received' (duration: 213.67659ms)","trace[1574813959] 'applied index is now lower than readState.Index' (duration: 189.153µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:13:40.519593Z","caller":"traceutil/trace.go:171","msg":"trace[2124704773] transaction","detail":"{read_only:false; response_revision:6509; number_of_response:1; }","duration":"281.557139ms","start":"2026-04-10T18:13:40.23797Z","end":"2026-04-10T18:13:40.519527Z","steps":["trace[2124704773] 'process raft request' (duration: 281.296654ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:13:40.519692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.115789ms","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-10T18:13:40.51977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.573637ms","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-10T18:13:40.519769Z","caller":"traceutil/trace.go:171","msg":"trace[1291700257] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6509; }","duration":"214.242711ms","start":"2026-04-10T18:13:40.305508Z","end":"2026-04-10T18:13:40.519751Z","steps":["trace[1291700257] 'agreement among raft nodes before linearized reading' (duration: 214.027196ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:13:40.519811Z","caller":"traceutil/trace.go:171","msg":"trace[1370315238] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6509; }","duration":"200.692759ms","start":"2026-04-10T18:13:40.319107Z","end":"2026-04-10T18:13:40.5198Z","steps":["trace[1370315238] 'agreement among raft nodes before linearized reading' (duration: 200.512695ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:13:40.51981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.598756ms","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-10T18:13:40.519872Z","caller":"traceutil/trace.go:171","msg":"trace[66541004] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6509; }","duration":"152.71941ms","start":"2026-04-10T18:13:40.367138Z","end":"2026-04-10T18:13:40.519858Z","steps":["trace[66541004] 'agreement among raft nodes before linearized reading' (duration: 152.534445ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:13:40.51993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.414284ms","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-10T18:13:40.519983Z","caller":"traceutil/trace.go:171","msg":"trace[1640479572] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6509; }","duration":"186.501966ms","start":"2026-04-10T18:13:40.333467Z","end":"2026-04-10T18:13:40.519969Z","steps":["trace[1640479572] 'agreement among raft nodes before linearized reading' (duration: 186.322611ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:13:40.520023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.109658ms","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-10T18:13:40.520155Z","caller":"traceutil/trace.go:171","msg":"trace[1525927505] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:6509; }","duration":"169.295181ms","start":"2026-04-10T18:13:40.350835Z","end":"2026-04-10T18:13:40.52013Z","steps":["trace[1525927505] 'agreement among raft nodes before linearized reading' (duration: 168.924233ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:13:41.238183Z","caller":"traceutil/trace.go:171","msg":"trace[93415044] linearizableReadLoop","detail":"{readStateIndex:6746; appliedIndex:6745; }","duration":"190.134228ms","start":"2026-04-10T18:13:41.048024Z","end":"2026-04-10T18:13:41.238158Z","steps":["trace[93415044] 'read index received' (duration: 189.894024ms)","trace[93415044] 'applied index is now lower than readState.Index' (duration: 239.394µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:13:41.2383Z","caller":"traceutil/trace.go:171","msg":"trace[1928661948] transaction","detail":"{read_only:false; response_revision:6515; number_of_response:1; }","duration":"469.618718ms","start":"2026-04-10T18:13:40.768639Z","end":"2026-04-10T18:13:41.238258Z","steps":["trace[1928661948] 'process raft request' (duration: 469.359333ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:13:41.238362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.326933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-v5fzk\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-10T18:13:41.238586Z","caller":"traceutil/trace.go:171","msg":"trace[1670651814] range","detail":"{range_begin:/registry/pods/openstack/keepalived-v5fzk; range_end:; response_count:1; response_revision:6515; }","duration":"190.600488ms","start":"2026-04-10T18:13:41.047959Z","end":"2026-04-10T18:13:41.23856Z","steps":["trace[1670651814] 'agreement among raft nodes before linearized reading' (duration: 190.287702ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:13:41.238677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:13:40.768614Z","time spent":"469.800411ms","remote":"127.0.0.1:50706","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-10T18:17:38.045424Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6085} {"level":"info","ts":"2026-04-10T18:17:38.141155Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6085,"took":"94.138706ms","hash":1519025009,"current-db-size-bytes":57683968,"current-db-size":"58 MB","current-db-size-in-use-bytes":23719936,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-04-10T18:17:38.141238Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1519025009,"revision":6085,"compact-revision":3002} {"level":"info","ts":"2026-04-10T18:17:39.547195Z","caller":"traceutil/trace.go:171","msg":"trace[1161140833] linearizableReadLoop","detail":"{readStateIndex:8605; appliedIndex:8604; }","duration":"164.806895ms","start":"2026-04-10T18:17:39.382369Z","end":"2026-04-10T18:17:39.547176Z","steps":["trace[1161140833] 'read index received' (duration: 164.670262ms)","trace[1161140833] 'applied index is now lower than readState.Index' (duration: 135.993µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:17:39.547307Z","caller":"traceutil/trace.go:171","msg":"trace[1179849858] transaction","detail":"{read_only:false; response_revision:8315; number_of_response:1; }","duration":"191.303452ms","start":"2026-04-10T18:17:39.355997Z","end":"2026-04-10T18:17:39.5473Z","steps":["trace[1179849858] 'process raft request' (duration: 191.058147ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:17:39.547489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.961547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:121827"} {"level":"info","ts":"2026-04-10T18:17:39.547539Z","caller":"traceutil/trace.go:171","msg":"trace[2100025337] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:8315; }","duration":"165.06495ms","start":"2026-04-10T18:17:39.382462Z","end":"2026-04-10T18:17:39.547527Z","steps":["trace[2100025337] 'agreement among raft nodes before linearized reading' (duration: 164.918407ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:17:39.548044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.665281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-04-10T18:17:39.548096Z","caller":"traceutil/trace.go:171","msg":"trace[72716939] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:8315; }","duration":"165.762474ms","start":"2026-04-10T18:17:39.382326Z","end":"2026-04-10T18:17:39.548088Z","steps":["trace[72716939] 'agreement among raft nodes before linearized reading' (duration: 165.192072ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:17:39.75778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.074493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T18:17:39.757855Z","caller":"traceutil/trace.go:171","msg":"trace[164552394] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8315; }","duration":"115.163974ms","start":"2026-04-10T18:17:39.642673Z","end":"2026-04-10T18:17:39.757837Z","steps":["trace[164552394] 'range keys from in-memory index tree' (duration: 114.912379ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:17:51.178905Z","caller":"traceutil/trace.go:171","msg":"trace[1292603329] transaction","detail":"{read_only:false; response_revision:8375; number_of_response:1; }","duration":"211.030535ms","start":"2026-04-10T18:17:50.967842Z","end":"2026-04-10T18:17:51.178873Z","steps":["trace[1292603329] 'process raft request' (duration: 163.63879ms)","trace[1292603329] 'compare' (duration: 47.169021ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:17:52.042332Z","caller":"traceutil/trace.go:171","msg":"trace[1745600292] transaction","detail":"{read_only:false; response_revision:8381; number_of_response:1; }","duration":"168.476127ms","start":"2026-04-10T18:17:51.873821Z","end":"2026-04-10T18:17:52.042297Z","steps":["trace[1745600292] 'process raft request' (duration: 153.462609ms)","trace[1745600292] 'compare' (duration: 14.835915ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:17:52.085241Z","caller":"traceutil/trace.go:171","msg":"trace[557892122] transaction","detail":"{read_only:false; response_revision:8382; number_of_response:1; }","duration":"211.131107ms","start":"2026-04-10T18:17:51.874086Z","end":"2026-04-10T18:17:52.085217Z","steps":["trace[557892122] 'process raft request' (duration: 210.967833ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:17:52.085581Z","caller":"traceutil/trace.go:171","msg":"trace[1883403281] transaction","detail":"{read_only:false; response_revision:8383; number_of_response:1; }","duration":"211.374082ms","start":"2026-04-10T18:17:51.874186Z","end":"2026-04-10T18:17:52.08556Z","steps":["trace[1883403281] 'process raft request' (duration: 210.989694ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:17:52.085627Z","caller":"traceutil/trace.go:171","msg":"trace[313627972] transaction","detail":"{read_only:false; response_revision:8384; number_of_response:1; }","duration":"211.272631ms","start":"2026-04-10T18:17:51.874324Z","end":"2026-04-10T18:17:52.085596Z","steps":["trace[313627972] 'process raft request' (duration: 211.128128ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:18:19.869207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.431221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T18:18:19.869275Z","caller":"traceutil/trace.go:171","msg":"trace[918917771] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8582; }","duration":"103.546104ms","start":"2026-04-10T18:18:19.765715Z","end":"2026-04-10T18:18:19.869261Z","steps":["trace[918917771] 'range keys from in-memory index tree' (duration: 103.34968ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:18:22.5134Z","caller":"traceutil/trace.go:171","msg":"trace[1849252199] linearizableReadLoop","detail":"{readStateIndex:8899; appliedIndex:8898; }","duration":"332.622188ms","start":"2026-04-10T18:18:22.180752Z","end":"2026-04-10T18:18:22.513375Z","steps":["trace[1849252199] 'read index received' (duration: 332.462514ms)","trace[1849252199] 'applied index is now lower than readState.Index' (duration: 158.894µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:18:22.513462Z","caller":"traceutil/trace.go:171","msg":"trace[809853543] transaction","detail":"{read_only:false; response_revision:8597; number_of_response:1; }","duration":"334.333863ms","start":"2026-04-10T18:18:22.179104Z","end":"2026-04-10T18:18:22.513438Z","steps":["trace[809853543] 'process raft request' (duration: 334.120289ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:18:22.513592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:18:22.179086Z","time spent":"334.429714ms","remote":"127.0.0.1:50706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T18:18:22.513643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.845972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-10T18:18:22.51376Z","caller":"traceutil/trace.go:171","msg":"trace[335065309] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:8597; }","duration":"333.029267ms","start":"2026-04-10T18:18:22.180702Z","end":"2026-04-10T18:18:22.513731Z","steps":["trace[335065309] 'agreement among raft nodes before linearized reading' (duration: 332.809031ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:18:22.513835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:18:22.180682Z","time spent":"333.132619ms","remote":"127.0.0.1:50844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-04-10T18:18:22.59621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.561465ms","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-10T18:18:22.596237Z","caller":"traceutil/trace.go:171","msg":"trace[1031732684] transaction","detail":"{read_only:false; response_revision:8598; number_of_response:1; }","duration":"379.072244ms","start":"2026-04-10T18:18:22.217138Z","end":"2026-04-10T18:18:22.59621Z","steps":["trace[1031732684] 'process raft request' (duration: 363.499473ms)","trace[1031732684] 'compare' (duration: 15.158703ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T18:18:22.596275Z","caller":"traceutil/trace.go:171","msg":"trace[563773687] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8599; }","duration":"360.677258ms","start":"2026-04-10T18:18:22.235584Z","end":"2026-04-10T18:18:22.596261Z","steps":["trace[563773687] 'agreement among raft nodes before linearized reading' (duration: 360.523095ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:18:22.596309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:18:22.235539Z","time spent":"360.76503ms","remote":"127.0.0.1:50706","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-10T18:18:22.596305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.327479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T18:18:22.596416Z","caller":"traceutil/trace.go:171","msg":"trace[1638975466] range","detail":"{range_begin:/registry/monitoring.coreos.com/probes/; range_end:/registry/monitoring.coreos.com/probes0; response_count:0; response_revision:8599; }","duration":"254.504032ms","start":"2026-04-10T18:18:22.341887Z","end":"2026-04-10T18:18:22.596392Z","steps":["trace[1638975466] 'agreement among raft nodes before linearized reading' (duration: 254.303609ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:18:22.596459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.991974ms","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-10T18:18:22.596486Z","caller":"traceutil/trace.go:171","msg":"trace[1859999419] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8599; }","duration":"360.035794ms","start":"2026-04-10T18:18:22.236443Z","end":"2026-04-10T18:18:22.596479Z","steps":["trace[1859999419] 'agreement among raft nodes before linearized reading' (duration: 359.940992ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:18:22.596513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:18:22.236433Z","time spent":"360.075685ms","remote":"127.0.0.1:50706","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-10T18:18:22.596354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:18:22.217111Z","time spent":"379.178346ms","remote":"127.0.0.1:50706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T18:18:22.596583Z","caller":"traceutil/trace.go:171","msg":"trace[600862686] transaction","detail":"{read_only:false; response_revision:8599; number_of_response:1; }","duration":"239.302019ms","start":"2026-04-10T18:18:22.35726Z","end":"2026-04-10T18:18:22.596562Z","steps":["trace[600862686] 'process raft request' (duration: 238.768458ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:18:22.596594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.832981ms","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-10T18:18:22.596669Z","caller":"traceutil/trace.go:171","msg":"trace[1421395143] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8599; }","duration":"360.969433ms","start":"2026-04-10T18:18:22.23568Z","end":"2026-04-10T18:18:22.59665Z","steps":["trace[1421395143] 'agreement among raft nodes before linearized reading' (duration: 360.734759ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:18:22.596722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:18:22.235645Z","time spent":"361.067106ms","remote":"127.0.0.1:50706","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-10T18:18:33.161671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.498502ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T18:18:33.161782Z","caller":"traceutil/trace.go:171","msg":"trace[2021753343] transaction","detail":"{read_only:false; response_revision:8701; number_of_response:1; }","duration":"473.753542ms","start":"2026-04-10T18:18:32.68801Z","end":"2026-04-10T18:18:33.161764Z","steps":["trace[2021753343] 'process raft request' (duration: 229.087805ms)","trace[2021753343] 'compare' (duration: 244.392121ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T18:18:33.161888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T18:18:32.68799Z","time spent":"473.828854ms","remote":"127.0.0.1:50706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T18:18:33.196229Z","caller":"traceutil/trace.go:171","msg":"trace[45580073] transaction","detail":"{read_only:false; response_revision:8702; number_of_response:1; }","duration":"272.316437ms","start":"2026-04-10T18:18:32.923894Z","end":"2026-04-10T18:18:33.19621Z","steps":["trace[45580073] 'process raft request' (duration: 272.170854ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:18:33.196654Z","caller":"traceutil/trace.go:171","msg":"trace[1974301899] linearizableReadLoop","detail":"{readStateIndex:9008; appliedIndex:9007; }","duration":"243.820789ms","start":"2026-04-10T18:18:32.952811Z","end":"2026-04-10T18:18:33.196632Z","steps":["trace[1974301899] 'read index received' (duration: 243.110815ms)","trace[1974301899] 'applied index is now lower than readState.Index' (duration: 708.264µs)"],"step_count":2} {"level":"warn","ts":"2026-04-10T18:18:33.196873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.050763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-v5fzk\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-10T18:18:33.196903Z","caller":"traceutil/trace.go:171","msg":"trace[1799841853] range","detail":"{range_begin:/registry/pods/openstack/keepalived-v5fzk; range_end:; response_count:1; response_revision:8702; }","duration":"244.116265ms","start":"2026-04-10T18:18:32.952777Z","end":"2026-04-10T18:18:33.196894Z","steps":["trace[1799841853] 'agreement among raft nodes before linearized reading' (duration: 243.983953ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T18:18:33.197405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.888018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:5146"} {"level":"info","ts":"2026-04-10T18:18:33.197443Z","caller":"traceutil/trace.go:171","msg":"trace[409049634] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:8702; }","duration":"131.96295ms","start":"2026-04-10T18:18:33.065469Z","end":"2026-04-10T18:18:33.197432Z","steps":["trace[409049634] 'agreement among raft nodes before linearized reading' (duration: 131.749515ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:18:33.417487Z","caller":"traceutil/trace.go:171","msg":"trace[54123546] transaction","detail":"{read_only:false; response_revision:8703; number_of_response:1; }","duration":"205.827722ms","start":"2026-04-10T18:18:33.211635Z","end":"2026-04-10T18:18:33.417462Z","steps":["trace[54123546] 'process raft request' (duration: 205.608878ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:18:33.439522Z","caller":"traceutil/trace.go:171","msg":"trace[980276046] transaction","detail":"{read_only:false; response_revision:8704; number_of_response:1; }","duration":"213.077336ms","start":"2026-04-10T18:18:33.226402Z","end":"2026-04-10T18:18:33.439479Z","steps":["trace[980276046] 'process raft request' (duration: 212.666108ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:18:33.974624Z","caller":"traceutil/trace.go:171","msg":"trace[1155425360] transaction","detail":"{read_only:false; response_revision:8707; number_of_response:1; }","duration":"109.943722ms","start":"2026-04-10T18:18:33.864658Z","end":"2026-04-10T18:18:33.974601Z","steps":["trace[1155425360] 'process raft request' (duration: 109.797639ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:19:11.1686Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002497.wal"} {"level":"warn","ts":"2026-04-10T18:19:48.049317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.936938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T18:19:48.0494Z","caller":"traceutil/trace.go:171","msg":"trace[870132545] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9440; }","duration":"222.081831ms","start":"2026-04-10T18:19:47.827301Z","end":"2026-04-10T18:19:48.049383Z","steps":["trace[870132545] 'range keys from in-memory index tree' (duration: 221.832337ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T18:20:19.882904Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"1a532052a1358225","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-10T18:20:19.888281Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-10T18:20:19.88843Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-10T18:22:38.052487Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8310} {"level":"info","ts":"2026-04-10T18:22:38.133949Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8310,"took":"79.056486ms","hash":2157857946,"current-db-size-bytes":57683968,"current-db-size":"58 MB","current-db-size-in-use-bytes":25997312,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-04-10T18:22:38.134012Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2157857946,"revision":8310,"compact-revision":6085} {"level":"info","ts":"2026-04-10T18:27:38.058143Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10707} {"level":"info","ts":"2026-04-10T18:27:38.131802Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10707,"took":"71.312304ms","hash":3290053527,"current-db-size-bytes":57683968,"current-db-size":"58 MB","current-db-size-in-use-bytes":20561920,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-10T18:27:38.131853Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3290053527,"revision":10707,"compact-revision":8310}