{"level":"warn","ts":"2026-09-15T02:26:19.604017Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-15T02:26:19.604138Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.81: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://162.253.55.81:2380","--initial-cluster=instance=https://162.253.55.81:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.81:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.81: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-09-15T02:26:19.604221Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-15T02:26:19.604241Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.81:2380"]} {"level":"info","ts":"2026-09-15T02:26:19.604265Z","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-09-15T02:26:19.6052Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.81:2379"]} {"level":"info","ts":"2026-09-15T02:26:19.605307Z","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://162.253.55.81:2380"],"listen-peer-urls":["https://162.253.55.81:2380"],"advertise-client-urls":["https://162.253.55.81:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.81:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.81: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-09-15T02:26:19.60795Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.384309ms"} {"level":"info","ts":"2026-09-15T02:26:19.613951Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d346c241c42fcdea","cluster-id":"331f16aa5aa938b6"} {"level":"info","ts":"2026-09-15T02:26:19.614023Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d346c241c42fcdea switched to configuration voters=()"} {"level":"info","ts":"2026-09-15T02:26:19.614045Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d346c241c42fcdea became follower at term 0"} {"level":"info","ts":"2026-09-15T02:26:19.614063Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d346c241c42fcdea [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-15T02:26:19.614071Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d346c241c42fcdea became follower at term 1"} {"level":"info","ts":"2026-09-15T02:26:19.614107Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d346c241c42fcdea switched to configuration voters=(15224069178092670442)"} {"level":"warn","ts":"2026-09-15T02:26:19.620549Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-15T02:26:19.623347Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-15T02:26:19.626064Z","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-09-15T02:26:19.631068Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d346c241c42fcdea","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-15T02:26:19.631322Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d346c241c42fcdea","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-15T02:26:19.63158Z","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-09-15T02:26:19.631783Z","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-09-15T02:26:19.631803Z","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-09-15T02:26:19.63412Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d346c241c42fcdea switched to configuration voters=(15224069178092670442)"} {"level":"info","ts":"2026-09-15T02:26:19.635149Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"331f16aa5aa938b6","local-member-id":"d346c241c42fcdea","added-peer-id":"d346c241c42fcdea","added-peer-peer-urls":["https://162.253.55.81:2380"]} {"level":"info","ts":"2026-09-15T02:26:19.637062Z","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-09-15T02:26:19.637379Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d346c241c42fcdea","initial-advertise-peer-urls":["https://162.253.55.81:2380"],"listen-peer-urls":["https://162.253.55.81:2380"],"advertise-client-urls":["https://162.253.55.81:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.81:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-15T02:26:19.637422Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-15T02:26:19.637617Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.81:2380"} {"level":"info","ts":"2026-09-15T02:26:19.637711Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.81:2380"} {"level":"info","ts":"2026-09-15T02:26:20.116789Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d346c241c42fcdea is starting a new election at term 1"} {"level":"info","ts":"2026-09-15T02:26:20.116868Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d346c241c42fcdea became pre-candidate at term 1"} {"level":"info","ts":"2026-09-15T02:26:20.1169Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d346c241c42fcdea received MsgPreVoteResp from d346c241c42fcdea at term 1"} {"level":"info","ts":"2026-09-15T02:26:20.116921Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d346c241c42fcdea became candidate at term 2"} {"level":"info","ts":"2026-09-15T02:26:20.116931Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d346c241c42fcdea received MsgVoteResp from d346c241c42fcdea at term 2"} {"level":"info","ts":"2026-09-15T02:26:20.116962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d346c241c42fcdea became leader at term 2"} {"level":"info","ts":"2026-09-15T02:26:20.116976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d346c241c42fcdea elected leader d346c241c42fcdea at term 2"} {"level":"info","ts":"2026-09-15T02:26:20.128942Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-15T02:26:20.134907Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-15T02:26:20.134902Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d346c241c42fcdea","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.81:2379]}","request-path":"/0/members/d346c241c42fcdea/attributes","cluster-id":"331f16aa5aa938b6","publish-timeout":"7s"} {"level":"info","ts":"2026-09-15T02:26:20.134992Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-15T02:26:20.135366Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-15T02:26:20.135394Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-15T02:26:20.138127Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-15T02:26:20.139312Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.81:2379"} {"level":"info","ts":"2026-09-15T02:26:20.144806Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"331f16aa5aa938b6","local-member-id":"d346c241c42fcdea","cluster-version":"3.5"} {"level":"info","ts":"2026-09-15T02:26:20.144965Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-15T02:26:20.14502Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-15T02:26:23.155867Z","caller":"traceutil/trace.go:171","msg":"trace[1674484634] transaction","detail":"{read_only:false; response_revision:109; number_of_response:1; }","duration":"101.31181ms","start":"2026-09-15T02:26:23.054525Z","end":"2026-09-15T02:26:23.155837Z","steps":["trace[1674484634] 'process raft request' (duration: 101.167116ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:27:11.694515Z","caller":"traceutil/trace.go:171","msg":"trace[2107365838] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"107.55908ms","start":"2026-09-15T02:27:11.586928Z","end":"2026-09-15T02:27:11.694487Z","steps":["trace[2107365838] 'process raft request' (duration: 107.423606ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:27:11.862225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.339874ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-15T02:27:11.862428Z","caller":"traceutil/trace.go:171","msg":"trace[731420083] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:632; }","duration":"155.483043ms","start":"2026-09-15T02:27:11.706918Z","end":"2026-09-15T02:27:11.862401Z","steps":["trace[731420083] 'read index received' (duration: 37.915266ms)","trace[731420083] 'applied index is now lower than readState.Index' (duration: 117.565917ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T02:27:11.86252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.608807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:27:11.86248Z","caller":"traceutil/trace.go:171","msg":"trace[935740164] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"203.963103ms","start":"2026-09-15T02:27:11.658468Z","end":"2026-09-15T02:27:11.862431Z","steps":["trace[935740164] 'process raft request' (duration: 86.448907ms)","trace[935740164] 'compare' (duration: 116.042556ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:27:11.86257Z","caller":"traceutil/trace.go:171","msg":"trace[919693970] range","detail":"{range_begin:/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system; range_end:; response_count:0; response_revision:607; }","duration":"155.695649ms","start":"2026-09-15T02:27:11.706857Z","end":"2026-09-15T02:27:11.862553Z","steps":["trace[919693970] 'agreement among raft nodes before linearized reading' (duration: 155.610727ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:27:12.223302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.314787ms","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-09-15T02:27:12.223396Z","caller":"traceutil/trace.go:171","msg":"trace[1830013239] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:607; }","duration":"107.473921ms","start":"2026-09-15T02:27:12.115901Z","end":"2026-09-15T02:27:12.223375Z","steps":["trace[1830013239] 'range keys from in-memory index tree' (duration: 107.088531ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:27:12.935554Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14837848543778792219,"retry-timeout":"500ms"} {"level":"info","ts":"2026-09-15T02:27:12.941118Z","caller":"traceutil/trace.go:171","msg":"trace[316587519] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"653.893277ms","start":"2026-09-15T02:27:12.287192Z","end":"2026-09-15T02:27:12.941086Z","steps":["trace[316587519] 'process raft request' (duration: 653.165487ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:27:12.941309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:27:12.287152Z","time spent":"654.057411ms","remote":"127.0.0.1:42592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036257,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-15T02:27:12.974042Z","caller":"traceutil/trace.go:171","msg":"trace[173224107] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:634; }","duration":"539.212306ms","start":"2026-09-15T02:27:12.434799Z","end":"2026-09-15T02:27:12.974012Z","steps":["trace[173224107] 'read index received' (duration: 505.379551ms)","trace[173224107] 'applied index is now lower than readState.Index' (duration: 33.831385ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T02:27:12.97461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.769272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-15T02:27:12.974641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.213418ms","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-09-15T02:27:12.974736Z","caller":"traceutil/trace.go:171","msg":"trace[1612311845] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:610; }","duration":"539.980878ms","start":"2026-09-15T02:27:12.434723Z","end":"2026-09-15T02:27:12.974704Z","steps":["trace[1612311845] 'agreement among raft nodes before linearized reading' (duration: 539.751572ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:27:12.974755Z","caller":"traceutil/trace.go:171","msg":"trace[237277904] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:610; }","duration":"258.425244ms","start":"2026-09-15T02:27:12.716296Z","end":"2026-09-15T02:27:12.974721Z","steps":["trace[237277904] 'agreement among raft nodes before linearized reading' (duration: 258.151677ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:27:12.974796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:27:12.434695Z","time spent":"540.091311ms","remote":"127.0.0.1:42464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-15T02:27:30.742866Z","caller":"traceutil/trace.go:171","msg":"trace[2135429719] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"241.691422ms","start":"2026-09-15T02:27:30.501134Z","end":"2026-09-15T02:27:30.742825Z","steps":["trace[2135429719] 'process raft request' (duration: 241.352523ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:27:30.742833Z","caller":"traceutil/trace.go:171","msg":"trace[794455347] linearizableReadLoop","detail":"{readStateIndex:815; appliedIndex:814; }","duration":"235.632164ms","start":"2026-09-15T02:27:30.50716Z","end":"2026-09-15T02:27:30.742792Z","steps":["trace[794455347] 'read index received' (duration: 235.288685ms)","trace[794455347] 'applied index is now lower than readState.Index' (duration: 342.049µs)"],"step_count":2} {"level":"warn","ts":"2026-09-15T02:27:30.743047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.838229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:27:30.74384Z","caller":"traceutil/trace.go:171","msg":"trace[2037361408] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:783; }","duration":"236.663182ms","start":"2026-09-15T02:27:30.507135Z","end":"2026-09-15T02:27:30.743798Z","steps":["trace[2037361408] 'agreement among raft nodes before linearized reading' (duration: 235.805529ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:27:30.743964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.066487ms","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-09-15T02:27:30.744059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.00117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:27:30.744058Z","caller":"traceutil/trace.go:171","msg":"trace[817732763] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:783; }","duration":"142.215431ms","start":"2026-09-15T02:27:30.601822Z","end":"2026-09-15T02:27:30.744037Z","steps":["trace[817732763] 'agreement among raft nodes before linearized reading' (duration: 142.064447ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:27:30.744143Z","caller":"traceutil/trace.go:171","msg":"trace[262654813] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:783; }","duration":"195.110573ms","start":"2026-09-15T02:27:30.549017Z","end":"2026-09-15T02:27:30.744128Z","steps":["trace[262654813] 'agreement among raft nodes before linearized reading' (duration: 194.962019ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:27:30.744003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.628001ms","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":"info","ts":"2026-09-15T02:27:30.74421Z","caller":"traceutil/trace.go:171","msg":"trace[616371965] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:783; }","duration":"236.95945ms","start":"2026-09-15T02:27:30.507221Z","end":"2026-09-15T02:27:30.744181Z","steps":["trace[616371965] 'agreement among raft nodes before linearized reading' (duration: 236.61629ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:27:30.744367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.234205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-15T02:27:30.744407Z","caller":"traceutil/trace.go:171","msg":"trace[190112564] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:783; }","duration":"162.324178ms","start":"2026-09-15T02:27:30.582073Z","end":"2026-09-15T02:27:30.744397Z","steps":["trace[190112564] 'agreement among raft nodes before linearized reading' (duration: 162.254426ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:27:30.744461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.035618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:27:30.744532Z","caller":"traceutil/trace.go:171","msg":"trace[2108528689] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:783; }","duration":"171.11831ms","start":"2026-09-15T02:27:30.573394Z","end":"2026-09-15T02:27:30.744512Z","steps":["trace[2108528689] 'agreement among raft nodes before linearized reading' (duration: 171.008087ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:27:30.744621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.212773ms","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":"info","ts":"2026-09-15T02:27:30.744666Z","caller":"traceutil/trace.go:171","msg":"trace[1028451615] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:783; }","duration":"171.347878ms","start":"2026-09-15T02:27:30.573308Z","end":"2026-09-15T02:27:30.744656Z","steps":["trace[1028451615] 'agreement among raft nodes before linearized reading' (duration: 171.239624ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:27:30.744663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.223732ms","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":"info","ts":"2026-09-15T02:27:30.744736Z","caller":"traceutil/trace.go:171","msg":"trace[618002572] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:783; }","duration":"142.278124ms","start":"2026-09-15T02:27:30.602414Z","end":"2026-09-15T02:27:30.744692Z","steps":["trace[618002572] 'agreement among raft nodes before linearized reading' (duration: 142.208832ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:27:30.744752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.41541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:27:30.744826Z","caller":"traceutil/trace.go:171","msg":"trace[531124685] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:783; }","duration":"205.533182ms","start":"2026-09-15T02:27:30.53925Z","end":"2026-09-15T02:27:30.744783Z","steps":["trace[531124685] 'agreement among raft nodes before linearized reading' (duration: 205.410449ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:27:30.744897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.026504ms","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":"warn","ts":"2026-09-15T02:27:30.744863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.42576ms","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":"info","ts":"2026-09-15T02:27:30.744953Z","caller":"traceutil/trace.go:171","msg":"trace[865419367] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:783; }","duration":"171.523523ms","start":"2026-09-15T02:27:30.573416Z","end":"2026-09-15T02:27:30.744939Z","steps":["trace[865419367] 'agreement among raft nodes before linearized reading' (duration: 171.41518ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:27:30.744975Z","caller":"traceutil/trace.go:171","msg":"trace[1953302361] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:783; }","duration":"143.093386ms","start":"2026-09-15T02:27:30.601832Z","end":"2026-09-15T02:27:30.744925Z","steps":["trace[1953302361] 'agreement among raft nodes before linearized reading' (duration: 143.033825ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:27:30.745389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.410664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-15T02:27:30.745417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.245312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:27:30.745437Z","caller":"traceutil/trace.go:171","msg":"trace[1013258549] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:783; }","duration":"237.498956ms","start":"2026-09-15T02:27:30.507922Z","end":"2026-09-15T02:27:30.745421Z","steps":["trace[1013258549] 'agreement among raft nodes before linearized reading' (duration: 237.402893ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:27:30.74546Z","caller":"traceutil/trace.go:171","msg":"trace[1235530445] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:783; }","duration":"206.320344ms","start":"2026-09-15T02:27:30.539128Z","end":"2026-09-15T02:27:30.745448Z","steps":["trace[1235530445] 'agreement among raft nodes before linearized reading' (duration: 206.251763ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:27:30.745659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.121356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:27:30.745768Z","caller":"traceutil/trace.go:171","msg":"trace[180279565] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:783; }","duration":"207.421494ms","start":"2026-09-15T02:27:30.538319Z","end":"2026-09-15T02:27:30.74574Z","steps":["trace[180279565] 'agreement among raft nodes before linearized reading' (duration: 207.091365ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:27:30.888857Z","caller":"traceutil/trace.go:171","msg":"trace[877273723] linearizableReadLoop","detail":"{readStateIndex:816; appliedIndex:815; }","duration":"121.057766ms","start":"2026-09-15T02:27:30.767762Z","end":"2026-09-15T02:27:30.888819Z","steps":["trace[877273723] 'read index received' (duration: 120.584333ms)","trace[877273723] 'applied index is now lower than readState.Index' (duration: 471.683µs)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:27:30.889418Z","caller":"traceutil/trace.go:171","msg":"trace[174988971] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"129.361736ms","start":"2026-09-15T02:27:30.760016Z","end":"2026-09-15T02:27:30.889378Z","steps":["trace[174988971] 'process raft request' (duration: 128.437611ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:27:30.889556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.649253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:27:30.889655Z","caller":"traceutil/trace.go:171","msg":"trace[1308248954] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:784; }","duration":"121.818637ms","start":"2026-09-15T02:27:30.767813Z","end":"2026-09-15T02:27:30.889632Z","steps":["trace[1308248954] 'agreement among raft nodes before linearized reading' (duration: 121.654422ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:27:30.889993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.223028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:27:30.89004Z","caller":"traceutil/trace.go:171","msg":"trace[1440982513] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:784; }","duration":"122.319851ms","start":"2026-09-15T02:27:30.767707Z","end":"2026-09-15T02:27:30.890027Z","steps":["trace[1440982513] 'agreement among raft nodes before linearized reading' (duration: 122.244859ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:27:30.890237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.693534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:27:30.890286Z","caller":"traceutil/trace.go:171","msg":"trace[104019202] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:784; }","duration":"121.774315ms","start":"2026-09-15T02:27:30.768498Z","end":"2026-09-15T02:27:30.890273Z","steps":["trace[104019202] 'agreement among raft nodes before linearized reading' (duration: 121.696453ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:28:01.095946Z","caller":"traceutil/trace.go:171","msg":"trace[211560701] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"186.267591ms","start":"2026-09-15T02:28:00.909643Z","end":"2026-09-15T02:28:01.09591Z","steps":["trace[211560701] 'process raft request' (duration: 186.069155ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:28:17.504633Z","caller":"traceutil/trace.go:171","msg":"trace[1377685674] transaction","detail":"{read_only:false; response_revision:1321; number_of_response:1; }","duration":"125.682401ms","start":"2026-09-15T02:28:17.378822Z","end":"2026-09-15T02:28:17.504505Z","steps":["trace[1377685674] 'process raft request' (duration: 124.746646ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:28:25.39439Z","caller":"traceutil/trace.go:171","msg":"trace[1194564611] transaction","detail":"{read_only:false; response_revision:1449; number_of_response:1; }","duration":"114.760724ms","start":"2026-09-15T02:28:25.279583Z","end":"2026-09-15T02:28:25.394344Z","steps":["trace[1194564611] 'process raft request' (duration: 114.427524ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:28:52.55932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.264019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:28:52.559451Z","caller":"traceutil/trace.go:171","msg":"trace[2044694145] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1878; }","duration":"125.466785ms","start":"2026-09-15T02:28:52.43396Z","end":"2026-09-15T02:28:52.559426Z","steps":["trace[2044694145] 'range keys from in-memory index tree' (duration: 125.147406ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:28:52.559521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.856601ms","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-09-15T02:28:52.559644Z","caller":"traceutil/trace.go:171","msg":"trace[228759840] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1878; }","duration":"105.993814ms","start":"2026-09-15T02:28:52.453626Z","end":"2026-09-15T02:28:52.55962Z","steps":["trace[228759840] 'range keys from in-memory index tree' (duration: 105.634326ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:28:52.840933Z","caller":"traceutil/trace.go:171","msg":"trace[1727814146] transaction","detail":"{read_only:false; response_revision:1880; number_of_response:1; }","duration":"159.865751ms","start":"2026-09-15T02:28:52.681032Z","end":"2026-09-15T02:28:52.840898Z","steps":["trace[1727814146] 'process raft request' (duration: 149.969572ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:28:53.044055Z","caller":"traceutil/trace.go:171","msg":"trace[1190845975] transaction","detail":"{read_only:false; response_revision:1881; number_of_response:1; }","duration":"159.273275ms","start":"2026-09-15T02:28:52.88474Z","end":"2026-09-15T02:28:53.044013Z","steps":["trace[1190845975] 'process raft request' (duration: 108.700798ms)","trace[1190845975] 'compare' (duration: 50.269688ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:28:53.044792Z","caller":"traceutil/trace.go:171","msg":"trace[428040809] transaction","detail":"{read_only:false; response_revision:1882; number_of_response:1; }","duration":"158.770871ms","start":"2026-09-15T02:28:52.885421Z","end":"2026-09-15T02:28:53.044192Z","steps":["trace[428040809] 'process raft request' (duration: 158.522825ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:28:53.613647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.210449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-de5be2bf-fbf7-4333-ad5d-7fceea252f5e\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-09-15T02:28:53.613768Z","caller":"traceutil/trace.go:171","msg":"trace[1582256130] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-de5be2bf-fbf7-4333-ad5d-7fceea252f5e; range_end:; response_count:1; response_revision:1882; }","duration":"401.384433ms","start":"2026-09-15T02:28:53.21234Z","end":"2026-09-15T02:28:53.613725Z","steps":["trace[1582256130] 'range keys from in-memory index tree' (duration: 400.996713ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:28:53.613775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.890003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-15T02:28:53.61383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.598418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:28:53.613876Z","caller":"traceutil/trace.go:171","msg":"trace[1737825937] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:1882; }","duration":"400.051027ms","start":"2026-09-15T02:28:53.213797Z","end":"2026-09-15T02:28:53.613848Z","steps":["trace[1737825937] 'count revisions from in-memory index tree' (duration: 399.77688ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:28:53.613903Z","caller":"traceutil/trace.go:171","msg":"trace[1438600167] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1882; }","duration":"179.728801ms","start":"2026-09-15T02:28:53.434158Z","end":"2026-09-15T02:28:53.613886Z","steps":["trace[1438600167] 'range keys from in-memory index tree' (duration: 179.440283ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:28:53.613931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:28:53.21377Z","time spent":"400.1451ms","remote":"127.0.0.1:40066","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-09-15T02:28:53.613838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:28:53.212328Z","time spent":"401.495956ms","remote":"127.0.0.1:42690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-de5be2bf-fbf7-4333-ad5d-7fceea252f5e\" "} {"level":"warn","ts":"2026-09-15T02:28:53.614053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.549818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-de5be2bf-fbf7-4333-ad5d-7fceea252f5e\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-09-15T02:28:53.614198Z","caller":"traceutil/trace.go:171","msg":"trace[563249223] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-de5be2bf-fbf7-4333-ad5d-7fceea252f5e; range_end:; response_count:1; response_revision:1882; }","duration":"462.756113ms","start":"2026-09-15T02:28:53.151413Z","end":"2026-09-15T02:28:53.614169Z","steps":["trace[563249223] 'range keys from in-memory index tree' (duration: 462.24614ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:28:53.614308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:28:53.151394Z","time spent":"462.894207ms","remote":"127.0.0.1:42690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-de5be2bf-fbf7-4333-ad5d-7fceea252f5e\" "} {"level":"info","ts":"2026-09-15T02:29:05.788266Z","caller":"traceutil/trace.go:171","msg":"trace[1878380203] transaction","detail":"{read_only:false; response_revision:1995; number_of_response:1; }","duration":"100.915007ms","start":"2026-09-15T02:29:05.687324Z","end":"2026-09-15T02:29:05.788239Z","steps":["trace[1878380203] 'process raft request' (duration: 100.291ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:29:05.919753Z","caller":"traceutil/trace.go:171","msg":"trace[441395614] transaction","detail":"{read_only:false; response_revision:1996; number_of_response:1; }","duration":"126.553304ms","start":"2026-09-15T02:29:05.793159Z","end":"2026-09-15T02:29:05.919712Z","steps":["trace[441395614] 'process raft request' (duration: 119.521282ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:29:05.924041Z","caller":"traceutil/trace.go:171","msg":"trace[627051446] transaction","detail":"{read_only:false; response_revision:1997; number_of_response:1; }","duration":"130.009798ms","start":"2026-09-15T02:29:05.793996Z","end":"2026-09-15T02:29:05.924006Z","steps":["trace[627051446] 'process raft request' (duration: 129.854564ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:29:06.354724Z","caller":"traceutil/trace.go:171","msg":"trace[1157180380] transaction","detail":"{read_only:false; response_revision:1998; number_of_response:1; }","duration":"201.470873ms","start":"2026-09-15T02:29:06.153227Z","end":"2026-09-15T02:29:06.354698Z","steps":["trace[1157180380] 'process raft request' (duration: 201.260057ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:29:32.169628Z","caller":"traceutil/trace.go:171","msg":"trace[1991367738] transaction","detail":"{read_only:false; response_revision:2145; number_of_response:1; }","duration":"112.135215ms","start":"2026-09-15T02:29:32.057416Z","end":"2026-09-15T02:29:32.169551Z","steps":["trace[1991367738] 'process raft request' (duration: 111.840517ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:29:32.169545Z","caller":"traceutil/trace.go:171","msg":"trace[998256971] linearizableReadLoop","detail":"{readStateIndex:2230; appliedIndex:2229; }","duration":"110.734066ms","start":"2026-09-15T02:29:32.058774Z","end":"2026-09-15T02:29:32.169508Z","steps":["trace[998256971] 'read index received' (duration: 110.449898ms)","trace[998256971] 'applied index is now lower than readState.Index' (duration: 282.878µs)"],"step_count":2} {"level":"warn","ts":"2026-09-15T02:29:32.169863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.061624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-15T02:29:32.169938Z","caller":"traceutil/trace.go:171","msg":"trace[1393467096] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2145; }","duration":"111.215029ms","start":"2026-09-15T02:29:32.058706Z","end":"2026-09-15T02:29:32.169921Z","steps":["trace[1393467096] 'agreement among raft nodes before linearized reading' (duration: 110.955702ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:29:37.537418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.646116ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-15T02:29:37.537643Z","caller":"traceutil/trace.go:171","msg":"trace[1841673461] transaction","detail":"{read_only:false; response_revision:2174; number_of_response:1; }","duration":"192.642866ms","start":"2026-09-15T02:29:37.344976Z","end":"2026-09-15T02:29:37.537619Z","steps":["trace[1841673461] 'process raft request' (duration: 53.673251ms)","trace[1841673461] 'compare' (duration: 138.488962ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:29:37.537891Z","caller":"traceutil/trace.go:171","msg":"trace[1422124416] transaction","detail":"{read_only:false; response_revision:2175; number_of_response:1; }","duration":"174.245089ms","start":"2026-09-15T02:29:37.363618Z","end":"2026-09-15T02:29:37.537863Z","steps":["trace[1422124416] 'process raft request' (duration: 173.932831ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:29:43.168604Z","caller":"traceutil/trace.go:171","msg":"trace[1651142758] transaction","detail":"{read_only:false; response_revision:2204; number_of_response:1; }","duration":"125.613216ms","start":"2026-09-15T02:29:43.042906Z","end":"2026-09-15T02:29:43.168519Z","steps":["trace[1651142758] 'process raft request' (duration: 100.960556ms)","trace[1651142758] 'compare' (duration: 24.30403ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:29:43.570138Z","caller":"traceutil/trace.go:171","msg":"trace[1778907785] linearizableReadLoop","detail":"{readStateIndex:2293; appliedIndex:2292; }","duration":"135.948502ms","start":"2026-09-15T02:29:43.434153Z","end":"2026-09-15T02:29:43.570101Z","steps":["trace[1778907785] 'read index received' (duration: 135.652864ms)","trace[1778907785] 'applied index is now lower than readState.Index' (duration: 294.148µs)"],"step_count":2} {"level":"warn","ts":"2026-09-15T02:29:43.570382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.20538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:29:43.570465Z","caller":"traceutil/trace.go:171","msg":"trace[1679763406] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2205; }","duration":"136.365084ms","start":"2026-09-15T02:29:43.434083Z","end":"2026-09-15T02:29:43.570448Z","steps":["trace[1679763406] 'agreement among raft nodes before linearized reading' (duration: 136.211509ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:29:43.570206Z","caller":"traceutil/trace.go:171","msg":"trace[1485533313] transaction","detail":"{read_only:false; response_revision:2205; number_of_response:1; }","duration":"235.795158ms","start":"2026-09-15T02:29:43.334372Z","end":"2026-09-15T02:29:43.570167Z","steps":["trace[1485533313] 'process raft request' (duration: 235.5064ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:29:44.275289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.114443ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-15T02:29:44.275739Z","caller":"traceutil/trace.go:171","msg":"trace[234498007] transaction","detail":"{read_only:false; response_revision:2207; number_of_response:1; }","duration":"395.281331ms","start":"2026-09-15T02:29:43.88043Z","end":"2026-09-15T02:29:44.275711Z","steps":["trace[234498007] 'process raft request' (duration: 194.619132ms)","trace[234498007] 'compare' (duration: 199.933778ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:29:44.276226Z","caller":"traceutil/trace.go:171","msg":"trace[153197550] transaction","detail":"{read_only:false; response_revision:2208; number_of_response:1; }","duration":"327.379016ms","start":"2026-09-15T02:29:43.948625Z","end":"2026-09-15T02:29:44.276004Z","steps":["trace[153197550] 'process raft request' (duration: 326.787989ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:29:44.276309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.603727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-15T02:29:44.276391Z","caller":"traceutil/trace.go:171","msg":"trace[285555998] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2208; }","duration":"100.733611ms","start":"2026-09-15T02:29:44.175635Z","end":"2026-09-15T02:29:44.276369Z","steps":["trace[285555998] 'agreement among raft nodes before linearized reading' (duration: 100.101183ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:29:44.276066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:29:43.880402Z","time spent":"395.574089ms","remote":"127.0.0.1:42526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T02:29:44.276537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:29:43.948559Z","time spent":"327.809098ms","remote":"127.0.0.1:42796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-15T02:29:49.7427Z","caller":"traceutil/trace.go:171","msg":"trace[1064140540] linearizableReadLoop","detail":"{readStateIndex:2326; appliedIndex:2325; }","duration":"110.964943ms","start":"2026-09-15T02:29:49.631706Z","end":"2026-09-15T02:29:49.742671Z","steps":["trace[1064140540] 'read index received' (duration: 110.85326ms)","trace[1064140540] 'applied index is now lower than readState.Index' (duration: 109.903µs)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:29:49.742836Z","caller":"traceutil/trace.go:171","msg":"trace[339206006] transaction","detail":"{read_only:false; response_revision:2236; number_of_response:1; }","duration":"145.739952ms","start":"2026-09-15T02:29:49.597049Z","end":"2026-09-15T02:29:49.742789Z","steps":["trace[339206006] 'process raft request' (duration: 145.421753ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:29:49.742938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.20631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-15T02:29:49.742977Z","caller":"traceutil/trace.go:171","msg":"trace[1710931056] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2236; }","duration":"111.330293ms","start":"2026-09-15T02:29:49.631634Z","end":"2026-09-15T02:29:49.742965Z","steps":["trace[1710931056] 'agreement among raft nodes before linearized reading' (duration: 111.152418ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:31:14.828663Z","caller":"traceutil/trace.go:171","msg":"trace[1647196368] transaction","detail":"{read_only:false; response_revision:2891; number_of_response:1; }","duration":"175.639649ms","start":"2026-09-15T02:31:14.652971Z","end":"2026-09-15T02:31:14.828611Z","steps":["trace[1647196368] 'process raft request' (duration: 175.239498ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:31:15.221097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.791743ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-15T02:31:15.221256Z","caller":"traceutil/trace.go:171","msg":"trace[217775305] linearizableReadLoop","detail":"{readStateIndex:3010; appliedIndex:3009; }","duration":"132.172648ms","start":"2026-09-15T02:31:15.08906Z","end":"2026-09-15T02:31:15.221233Z","steps":["trace[217775305] 'read index received' (duration: 89.093µs)","trace[217775305] 'applied index is now lower than readState.Index' (duration: 132.082205ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:31:15.221301Z","caller":"traceutil/trace.go:171","msg":"trace[386057228] transaction","detail":"{read_only:false; response_revision:2895; number_of_response:1; }","duration":"311.105287ms","start":"2026-09-15T02:31:14.910147Z","end":"2026-09-15T02:31:15.221252Z","steps":["trace[386057228] 'process raft request' (duration: 131.028477ms)","trace[386057228] 'compare' (duration: 179.607967ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T02:31:15.221432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.379374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-15T02:31:15.221489Z","caller":"traceutil/trace.go:171","msg":"trace[648441908] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2895; }","duration":"132.490577ms","start":"2026-09-15T02:31:15.088968Z","end":"2026-09-15T02:31:15.221459Z","steps":["trace[648441908] 'agreement among raft nodes before linearized reading' (duration: 132.321442ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:31:15.221541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:31:14.910108Z","time spent":"311.287562ms","remote":"127.0.0.1:42796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-15T02:34:37.51112Z","caller":"traceutil/trace.go:171","msg":"trace[531206464] transaction","detail":"{read_only:false; response_revision:4157; number_of_response:1; }","duration":"108.917028ms","start":"2026-09-15T02:34:37.402161Z","end":"2026-09-15T02:34:37.511078Z","steps":["trace[531206464] 'process raft request' (duration: 108.174957ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:36:10.183959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.565991ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-15T02:36:10.184199Z","caller":"traceutil/trace.go:171","msg":"trace[1325861243] transaction","detail":"{read_only:false; response_revision:5236; number_of_response:1; }","duration":"189.025491ms","start":"2026-09-15T02:36:09.995153Z","end":"2026-09-15T02:36:10.184178Z","steps":["trace[1325861243] 'process raft request' (duration: 188.938769ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:36:10.184273Z","caller":"traceutil/trace.go:171","msg":"trace[1985401449] linearizableReadLoop","detail":"{readStateIndex:5437; appliedIndex:5436; }","duration":"231.068241ms","start":"2026-09-15T02:36:09.953163Z","end":"2026-09-15T02:36:10.184232Z","steps":["trace[1985401449] 'read index received' (duration: 98.14991ms)","trace[1985401449] 'applied index is now lower than readState.Index' (duration: 132.899961ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:36:10.184329Z","caller":"traceutil/trace.go:171","msg":"trace[20006848] transaction","detail":"{read_only:false; response_revision:5235; number_of_response:1; }","duration":"236.508192ms","start":"2026-09-15T02:36:09.947773Z","end":"2026-09-15T02:36:10.184281Z","steps":["trace[20006848] 'process raft request' (duration: 103.526309ms)","trace[20006848] 'compare' (duration: 132.350355ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T02:36:10.184519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.330819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:14422"} {"level":"info","ts":"2026-09-15T02:36:10.184567Z","caller":"traceutil/trace.go:171","msg":"trace[1481300960] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5236; }","duration":"231.418191ms","start":"2026-09-15T02:36:09.95313Z","end":"2026-09-15T02:36:10.184548Z","steps":["trace[1481300960] 'agreement among raft nodes before linearized reading' (duration: 231.225626ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:36:10.184578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.610154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-09-15T02:36:10.184624Z","caller":"traceutil/trace.go:171","msg":"trace[926725413] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5236; }","duration":"228.692765ms","start":"2026-09-15T02:36:09.955911Z","end":"2026-09-15T02:36:10.184604Z","steps":["trace[926725413] 'agreement among raft nodes before linearized reading' (duration: 228.49822ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:36:10.184785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.743326ms","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-09-15T02:36:10.184862Z","caller":"traceutil/trace.go:171","msg":"trace[1249838052] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:5236; }","duration":"136.87952ms","start":"2026-09-15T02:36:10.047964Z","end":"2026-09-15T02:36:10.184843Z","steps":["trace[1249838052] 'agreement among raft nodes before linearized reading' (duration: 136.741966ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:36:10.184918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.866809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-09-15T02:36:10.184958Z","caller":"traceutil/trace.go:171","msg":"trace[1280451274] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5236; }","duration":"216.91636ms","start":"2026-09-15T02:36:09.968031Z","end":"2026-09-15T02:36:10.184947Z","steps":["trace[1280451274] 'agreement among raft nodes before linearized reading' (duration: 216.814267ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:36:14.199207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.875956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4cbb0a41-a1f2-4100-a0bf-17091d9c8a8d\" ","response":"range_response_count:1 size:3600"} {"level":"info","ts":"2026-09-15T02:36:14.199286Z","caller":"traceutil/trace.go:171","msg":"trace[226888314] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4cbb0a41-a1f2-4100-a0bf-17091d9c8a8d; range_end:; response_count:1; response_revision:5393; }","duration":"307.011689ms","start":"2026-09-15T02:36:13.892259Z","end":"2026-09-15T02:36:14.19927Z","steps":["trace[226888314] 'range keys from in-memory index tree' (duration: 306.680029ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:36:14.199307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:36:13.892229Z","time spent":"307.072481ms","remote":"127.0.0.1:42690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3623,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4cbb0a41-a1f2-4100-a0bf-17091d9c8a8d\" "} {"level":"warn","ts":"2026-09-15T02:36:14.199206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.950958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:1 size:894"} {"level":"info","ts":"2026-09-15T02:36:14.199398Z","caller":"traceutil/trace.go:171","msg":"trace[1865530739] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:1; response_revision:5393; }","duration":"193.157064ms","start":"2026-09-15T02:36:14.006219Z","end":"2026-09-15T02:36:14.199376Z","steps":["trace[1865530739] 'range keys from in-memory index tree' (duration: 192.771594ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:36:14.199549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.285649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:786869"} {"level":"info","ts":"2026-09-15T02:36:14.199621Z","caller":"traceutil/trace.go:171","msg":"trace[1855235184] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5393; }","duration":"104.397893ms","start":"2026-09-15T02:36:14.095205Z","end":"2026-09-15T02:36:14.199603Z","steps":["trace[1855235184] 'range keys from in-memory index tree' (duration: 103.763476ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:36:14.199734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.95683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-m7bpm-tls\" ","response":"range_response_count:1 size:1966"} {"level":"info","ts":"2026-09-15T02:36:14.199897Z","caller":"traceutil/trace.go:171","msg":"trace[1204948537] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-m7bpm-tls; range_end:; response_count:1; response_revision:5393; }","duration":"289.240768ms","start":"2026-09-15T02:36:13.910632Z","end":"2026-09-15T02:36:14.199872Z","steps":["trace[1204948537] 'range keys from in-memory index tree' (duration: 288.220279ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:36:20.172686Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2919} {"level":"info","ts":"2026-09-15T02:36:20.271465Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2919,"took":"97.428751ms","hash":2805644573,"current-db-size-bytes":55603200,"current-db-size":"56 MB","current-db-size-in-use-bytes":30560256,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-09-15T02:36:20.271565Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2805644573,"revision":2919,"compact-revision":-1} {"level":"info","ts":"2026-09-15T02:36:27.660619Z","caller":"traceutil/trace.go:171","msg":"trace[1864793618] linearizableReadLoop","detail":"{readStateIndex:5829; appliedIndex:5828; }","duration":"101.538644ms","start":"2026-09-15T02:36:27.559056Z","end":"2026-09-15T02:36:27.660594Z","steps":["trace[1864793618] 'read index received' (duration: 101.357159ms)","trace[1864793618] 'applied index is now lower than readState.Index' (duration: 179.984µs)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:36:27.660748Z","caller":"traceutil/trace.go:171","msg":"trace[192519775] transaction","detail":"{read_only:false; response_revision:5615; number_of_response:1; }","duration":"178.242582ms","start":"2026-09-15T02:36:27.482443Z","end":"2026-09-15T02:36:27.660686Z","steps":["trace[192519775] 'process raft request' (duration: 177.974155ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:36:27.660854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.75881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:36:27.660928Z","caller":"traceutil/trace.go:171","msg":"trace[1874638677] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:5615; }","duration":"101.901714ms","start":"2026-09-15T02:36:27.559009Z","end":"2026-09-15T02:36:27.660911Z","steps":["trace[1874638677] 'agreement among raft nodes before linearized reading' (duration: 101.73359ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:36:28.937399Z","caller":"traceutil/trace.go:171","msg":"trace[467817916] transaction","detail":"{read_only:false; response_revision:5656; number_of_response:1; }","duration":"125.405823ms","start":"2026-09-15T02:36:28.811941Z","end":"2026-09-15T02:36:28.937347Z","steps":["trace[467817916] 'process raft request' (duration: 114.497222ms)","trace[467817916] 'compare' (duration: 10.693276ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T02:36:29.630136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.804551ms","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-09-15T02:36:29.630234Z","caller":"traceutil/trace.go:171","msg":"trace[1441669705] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5665; }","duration":"407.952975ms","start":"2026-09-15T02:36:29.222259Z","end":"2026-09-15T02:36:29.630212Z","steps":["trace[1441669705] 'range keys from in-memory index tree' (duration: 407.584975ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:36:29.630336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:36:29.22224Z","time spent":"408.085349ms","remote":"127.0.0.1:42796","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-09-15T02:36:29.63123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.787486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-15T02:36:29.631332Z","caller":"traceutil/trace.go:171","msg":"trace[68404036] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5665; }","duration":"405.91788ms","start":"2026-09-15T02:36:29.225393Z","end":"2026-09-15T02:36:29.63131Z","steps":["trace[68404036] 'range keys from in-memory index tree' (duration: 405.635882ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:36:29.631373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:36:29.225388Z","time spent":"405.975812ms","remote":"127.0.0.1:42796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-09-15T02:36:29.790295Z","caller":"traceutil/trace.go:171","msg":"trace[545066516] transaction","detail":"{read_only:false; response_revision:5668; number_of_response:1; }","duration":"124.019516ms","start":"2026-09-15T02:36:29.666254Z","end":"2026-09-15T02:36:29.790274Z","steps":["trace[545066516] 'process raft request' (duration: 123.818739ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:36:29.790216Z","caller":"traceutil/trace.go:171","msg":"trace[1001548735] transaction","detail":"{read_only:false; response_revision:5667; number_of_response:1; }","duration":"150.31231ms","start":"2026-09-15T02:36:29.63985Z","end":"2026-09-15T02:36:29.790162Z","steps":["trace[1001548735] 'process raft request' (duration: 141.840967ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:36:43.116441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.330242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-775597c4-2c41-4d03-979b-8da4b1a77687\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-09-15T02:36:43.116565Z","caller":"traceutil/trace.go:171","msg":"trace[1718623627] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-775597c4-2c41-4d03-979b-8da4b1a77687; range_end:; response_count:1; response_revision:5923; }","duration":"242.506457ms","start":"2026-09-15T02:36:42.874032Z","end":"2026-09-15T02:36:43.116538Z","steps":["trace[1718623627] 'range keys from in-memory index tree' (duration: 242.163647ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:37:37.415238Z","caller":"traceutil/trace.go:171","msg":"trace[2042005430] transaction","detail":"{read_only:false; response_revision:6366; number_of_response:1; }","duration":"100.756893ms","start":"2026-09-15T02:37:37.31445Z","end":"2026-09-15T02:37:37.415207Z","steps":["trace[2042005430] 'process raft request' (duration: 100.570468ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:37:37.721821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.333783ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-15T02:37:37.721942Z","caller":"traceutil/trace.go:171","msg":"trace[331872368] transaction","detail":"{read_only:false; response_revision:6367; number_of_response:1; }","duration":"285.120058ms","start":"2026-09-15T02:37:37.4368Z","end":"2026-09-15T02:37:37.72192Z","steps":["trace[331872368] 'process raft request' (duration: 125.55594ms)","trace[331872368] 'compare' (duration: 159.187828ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:41:20.179813Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5514} {"level":"info","ts":"2026-09-15T02:41:20.268833Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5514,"took":"86.699215ms","hash":3978037668,"current-db-size-bytes":55603200,"current-db-size":"56 MB","current-db-size-in-use-bytes":28487680,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-15T02:41:20.268919Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3978037668,"revision":5514,"compact-revision":2919} {"level":"info","ts":"2026-09-15T02:43:05.629448Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002372.wal"} {"level":"info","ts":"2026-09-15T02:43:06.105278Z","caller":"traceutil/trace.go:171","msg":"trace[697677945] transaction","detail":"{read_only:false; response_revision:8760; number_of_response:1; }","duration":"100.389784ms","start":"2026-09-15T02:43:06.004866Z","end":"2026-09-15T02:43:06.105256Z","steps":["trace[697677945] 'process raft request' (duration: 99.975742ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:43:06.317889Z","caller":"traceutil/trace.go:171","msg":"trace[1501259677] transaction","detail":"{read_only:false; response_revision:8761; number_of_response:1; }","duration":"180.923198ms","start":"2026-09-15T02:43:06.13693Z","end":"2026-09-15T02:43:06.317853Z","steps":["trace[1501259677] 'process raft request' (duration: 165.733759ms)","trace[1501259677] 'compare' (duration: 14.364217ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:43:06.318188Z","caller":"traceutil/trace.go:171","msg":"trace[782375304] transaction","detail":"{read_only:false; response_revision:8762; number_of_response:1; }","duration":"177.886156ms","start":"2026-09-15T02:43:06.140289Z","end":"2026-09-15T02:43:06.318175Z","steps":["trace[782375304] 'process raft request' (duration: 177.447363ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:43:06.318188Z","caller":"traceutil/trace.go:171","msg":"trace[488236527] linearizableReadLoop","detail":"{readStateIndex:9077; appliedIndex:9074; }","duration":"105.712072ms","start":"2026-09-15T02:43:06.212445Z","end":"2026-09-15T02:43:06.318157Z","steps":["trace[488236527] 'read index received' (duration: 90.220013ms)","trace[488236527] 'applied index is now lower than readState.Index' (duration: 15.491019ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T02:43:06.318332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.862885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-15T02:43:06.318375Z","caller":"traceutil/trace.go:171","msg":"trace[2128657340] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:8763; }","duration":"105.936297ms","start":"2026-09-15T02:43:06.212425Z","end":"2026-09-15T02:43:06.318361Z","steps":["trace[2128657340] 'agreement among raft nodes before linearized reading' (duration: 105.835004ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:43:06.318375Z","caller":"traceutil/trace.go:171","msg":"trace[938702444] transaction","detail":"{read_only:false; response_revision:8763; number_of_response:1; }","duration":"112.751596ms","start":"2026-09-15T02:43:06.205521Z","end":"2026-09-15T02:43:06.318273Z","steps":["trace[938702444] 'process raft request' (duration: 112.502238ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:43:19.774396Z","caller":"traceutil/trace.go:171","msg":"trace[924880228] transaction","detail":"{read_only:false; response_revision:8831; number_of_response:1; }","duration":"152.006859ms","start":"2026-09-15T02:43:19.62236Z","end":"2026-09-15T02:43:19.774367Z","steps":["trace[924880228] 'process raft request' (duration: 151.833385ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:43:49.868833Z","caller":"traceutil/trace.go:171","msg":"trace[218291817] linearizableReadLoop","detail":"{readStateIndex:9372; appliedIndex:9371; }","duration":"470.126259ms","start":"2026-09-15T02:43:49.398645Z","end":"2026-09-15T02:43:49.868771Z","steps":["trace[218291817] 'read index received' (duration: 469.680656ms)","trace[218291817] 'applied index is now lower than readState.Index' (duration: 444.343µs)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:43:49.869295Z","caller":"traceutil/trace.go:171","msg":"trace[1930054490] transaction","detail":"{read_only:false; response_revision:9046; number_of_response:1; }","duration":"519.532085ms","start":"2026-09-15T02:43:49.349741Z","end":"2026-09-15T02:43:49.869273Z","steps":["trace[1930054490] 'process raft request' (duration: 518.705402ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:43:49.869451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:43:49.349722Z","time spent":"519.643418ms","remote":"127.0.0.1:42796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T02:43:49.86967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.522681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-15T02:43:49.869707Z","caller":"traceutil/trace.go:171","msg":"trace[519648801] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9046; }","duration":"281.021105ms","start":"2026-09-15T02:43:49.588676Z","end":"2026-09-15T02:43:49.869697Z","steps":["trace[519648801] 'agreement among raft nodes before linearized reading' (duration: 280.902451ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:43:49.869668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.797276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-15T02:43:49.869857Z","caller":"traceutil/trace.go:171","msg":"trace[250260610] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:9046; }","duration":"109.016262ms","start":"2026-09-15T02:43:49.76082Z","end":"2026-09-15T02:43:49.869836Z","steps":["trace[250260610] 'agreement among raft nodes before linearized reading' (duration: 108.788156ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:43:49.870045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.065592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-15T02:43:49.870118Z","caller":"traceutil/trace.go:171","msg":"trace[619438442] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:9046; }","duration":"190.144564ms","start":"2026-09-15T02:43:49.679961Z","end":"2026-09-15T02:43:49.870106Z","steps":["trace[619438442] 'agreement among raft nodes before linearized reading' (duration: 189.813215ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:43:49.872336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.706688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-15T02:43:49.87239Z","caller":"traceutil/trace.go:171","msg":"trace[1229007094] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9046; }","duration":"473.809672ms","start":"2026-09-15T02:43:49.398565Z","end":"2026-09-15T02:43:49.872375Z","steps":["trace[1229007094] 'agreement among raft nodes before linearized reading' (duration: 470.669335ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:43:49.872464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:43:49.398532Z","time spent":"473.920564ms","remote":"127.0.0.1:42796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-15T02:43:51.677457Z","caller":"traceutil/trace.go:171","msg":"trace[1089937519] transaction","detail":"{read_only:false; response_revision:9055; number_of_response:1; }","duration":"190.37869ms","start":"2026-09-15T02:43:51.487042Z","end":"2026-09-15T02:43:51.677421Z","steps":["trace[1089937519] 'process raft request' (duration: 190.140344ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:44:03.179898Z","caller":"traceutil/trace.go:171","msg":"trace[1920796933] linearizableReadLoop","detail":"{readStateIndex:9457; appliedIndex:9455; }","duration":"146.674792ms","start":"2026-09-15T02:44:03.0332Z","end":"2026-09-15T02:44:03.179875Z","steps":["trace[1920796933] 'read index received' (duration: 6.430307ms)","trace[1920796933] 'applied index is now lower than readState.Index' (duration: 140.243555ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:44:03.180007Z","caller":"traceutil/trace.go:171","msg":"trace[1874202400] transaction","detail":"{read_only:false; response_revision:9130; number_of_response:1; }","duration":"146.254871ms","start":"2026-09-15T02:44:03.033741Z","end":"2026-09-15T02:44:03.179996Z","steps":["trace[1874202400] 'process raft request' (duration: 146.075496ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:44:03.18005Z","caller":"traceutil/trace.go:171","msg":"trace[1590510174] transaction","detail":"{read_only:false; response_revision:9129; number_of_response:1; }","duration":"169.333868ms","start":"2026-09-15T02:44:03.010667Z","end":"2026-09-15T02:44:03.180001Z","steps":["trace[1590510174] 'process raft request' (duration: 168.996319ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:44:03.180117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.894888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-8wsqs\" ","response":"range_response_count:1 size:4644"} {"level":"info","ts":"2026-09-15T02:44:03.18027Z","caller":"traceutil/trace.go:171","msg":"trace[1949806435] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-8wsqs; range_end:; response_count:1; response_revision:9130; }","duration":"147.097184ms","start":"2026-09-15T02:44:03.033153Z","end":"2026-09-15T02:44:03.18025Z","steps":["trace[1949806435] 'agreement among raft nodes before linearized reading' (duration: 146.880568ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:44:03.421262Z","caller":"traceutil/trace.go:171","msg":"trace[822314700] linearizableReadLoop","detail":"{readStateIndex:9459; appliedIndex:9458; }","duration":"241.269316ms","start":"2026-09-15T02:44:03.179961Z","end":"2026-09-15T02:44:03.42123Z","steps":["trace[822314700] 'read index received' (duration: 220.670167ms)","trace[822314700] 'applied index is now lower than readState.Index' (duration: 20.597699ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:44:03.421323Z","caller":"traceutil/trace.go:171","msg":"trace[917031168] transaction","detail":"{read_only:false; response_revision:9131; number_of_response:1; }","duration":"374.470916ms","start":"2026-09-15T02:44:03.046815Z","end":"2026-09-15T02:44:03.421286Z","steps":["trace[917031168] 'process raft request' (duration: 353.799875ms)","trace[917031168] 'compare' (duration: 20.440744ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T02:44:03.421538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.053556ms","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-09-15T02:44:03.421572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:44:03.046768Z","time spent":"374.64092ms","remote":"127.0.0.1:42796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-15T02:44:03.421596Z","caller":"traceutil/trace.go:171","msg":"trace[1488697853] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9131; }","duration":"293.16876ms","start":"2026-09-15T02:44:03.128403Z","end":"2026-09-15T02:44:03.421571Z","steps":["trace[1488697853] 'agreement among raft nodes before linearized reading' (duration: 292.972754ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:44:03.48309Z","caller":"traceutil/trace.go:171","msg":"trace[651544741] transaction","detail":"{read_only:false; response_revision:9132; number_of_response:1; }","duration":"292.135011ms","start":"2026-09-15T02:44:03.190929Z","end":"2026-09-15T02:44:03.483064Z","steps":["trace[651544741] 'process raft request' (duration: 291.904354ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:44:03.483216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.740297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-8wsqs\" ","response":"range_response_count:1 size:4649"} {"level":"info","ts":"2026-09-15T02:44:03.483272Z","caller":"traceutil/trace.go:171","msg":"trace[1983926071] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-8wsqs; range_end:; response_count:1; response_revision:9132; }","duration":"297.866101ms","start":"2026-09-15T02:44:03.185392Z","end":"2026-09-15T02:44:03.483259Z","steps":["trace[1983926071] 'agreement among raft nodes before linearized reading' (duration: 297.735976ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:44:03.483231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.663022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeaturerules/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeaturerules0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-15T02:44:03.483459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.592641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5fd8m\" ","response":"range_response_count:1 size:6441"} {"level":"info","ts":"2026-09-15T02:44:03.483513Z","caller":"traceutil/trace.go:171","msg":"trace[538392840] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeaturerules/; range_end:/registry/nfd.k8s-sigs.io/nodefeaturerules0; response_count:0; response_revision:9132; }","duration":"197.98425ms","start":"2026-09-15T02:44:03.285463Z","end":"2026-09-15T02:44:03.483447Z","steps":["trace[538392840] 'agreement among raft nodes before linearized reading' (duration: 197.623509ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:44:03.483543Z","caller":"traceutil/trace.go:171","msg":"trace[182986028] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5fd8m; range_end:; response_count:1; response_revision:9132; }","duration":"150.710514ms","start":"2026-09-15T02:44:03.332821Z","end":"2026-09-15T02:44:03.483531Z","steps":["trace[182986028] 'agreement among raft nodes before linearized reading' (duration: 150.439607ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:45:00.984783Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d346c241c42fcdea","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-15T02:45:00.996045Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-09-15T02:45:00.996166Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-09-15T02:45:18.410056Z","caller":"traceutil/trace.go:171","msg":"trace[1837193367] transaction","detail":"{read_only:false; response_revision:9895; number_of_response:1; }","duration":"100.504187ms","start":"2026-09-15T02:45:18.309519Z","end":"2026-09-15T02:45:18.410024Z","steps":["trace[1837193367] 'process raft request' (duration: 100.2518ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:45:18.465641Z","caller":"traceutil/trace.go:171","msg":"trace[1640165089] transaction","detail":"{read_only:false; response_revision:9896; number_of_response:1; }","duration":"101.947708ms","start":"2026-09-15T02:45:18.36363Z","end":"2026-09-15T02:45:18.465578Z","steps":["trace[1640165089] 'process raft request' (duration: 98.972136ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:45:29.584119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.696057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:45:29.584266Z","caller":"traceutil/trace.go:171","msg":"trace[162215939] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9963; }","duration":"149.912672ms","start":"2026-09-15T02:45:29.434324Z","end":"2026-09-15T02:45:29.584237Z","steps":["trace[162215939] 'range keys from in-memory index tree' (duration: 149.560543ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:45:34.60396Z","caller":"traceutil/trace.go:171","msg":"trace[926210021] transaction","detail":"{read_only:false; response_revision:9986; number_of_response:1; }","duration":"117.96655ms","start":"2026-09-15T02:45:34.485967Z","end":"2026-09-15T02:45:34.603933Z","steps":["trace[926210021] 'process raft request' (duration: 117.761203ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:45:34.807432Z","caller":"traceutil/trace.go:171","msg":"trace[193780145] linearizableReadLoop","detail":"{readStateIndex:10342; appliedIndex:10341; }","duration":"151.134166ms","start":"2026-09-15T02:45:34.656267Z","end":"2026-09-15T02:45:34.807401Z","steps":["trace[193780145] 'read index received' (duration: 132.718688ms)","trace[193780145] 'applied index is now lower than readState.Index' (duration: 18.411788ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:45:34.807463Z","caller":"traceutil/trace.go:171","msg":"trace[628324327] transaction","detail":"{read_only:false; response_revision:9987; number_of_response:1; }","duration":"168.531036ms","start":"2026-09-15T02:45:34.638875Z","end":"2026-09-15T02:45:34.807406Z","steps":["trace[628324327] 'process raft request' (duration: 150.143209ms)","trace[628324327] 'compare' (duration: 18.103449ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T02:45:34.807866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.573801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-09-15T02:45:34.808048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.752613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-15T02:45:34.80822Z","caller":"traceutil/trace.go:171","msg":"trace[398166507] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9988; }","duration":"151.979819ms","start":"2026-09-15T02:45:34.656225Z","end":"2026-09-15T02:45:34.808205Z","steps":["trace[398166507] 'agreement among raft nodes before linearized reading' (duration: 151.500216ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:45:34.80811Z","caller":"traceutil/trace.go:171","msg":"trace[1463885911] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9988; }","duration":"141.828348ms","start":"2026-09-15T02:45:34.666262Z","end":"2026-09-15T02:45:34.80809Z","steps":["trace[1463885911] 'agreement among raft nodes before linearized reading' (duration: 141.442787ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:45:34.953035Z","caller":"traceutil/trace.go:171","msg":"trace[572921141] transaction","detail":"{read_only:false; response_revision:9989; number_of_response:1; }","duration":"140.118621ms","start":"2026-09-15T02:45:34.812884Z","end":"2026-09-15T02:45:34.953003Z","steps":["trace[572921141] 'process raft request' (duration: 139.884195ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:45:34.961484Z","caller":"traceutil/trace.go:171","msg":"trace[1434073357] transaction","detail":"{read_only:false; response_revision:9990; number_of_response:1; }","duration":"147.763872ms","start":"2026-09-15T02:45:34.81369Z","end":"2026-09-15T02:45:34.961454Z","steps":["trace[1434073357] 'process raft request' (duration: 147.578857ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:45:39.418903Z","caller":"traceutil/trace.go:171","msg":"trace[385567927] transaction","detail":"{read_only:false; response_revision:10024; number_of_response:1; }","duration":"107.368616ms","start":"2026-09-15T02:45:39.3115Z","end":"2026-09-15T02:45:39.418869Z","steps":["trace[385567927] 'process raft request' (duration: 26.417989ms)","trace[385567927] 'compare' (duration: 80.094684ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:45:39.560469Z","caller":"traceutil/trace.go:171","msg":"trace[178972094] linearizableReadLoop","detail":"{readStateIndex:10383; appliedIndex:10381; }","duration":"127.193725ms","start":"2026-09-15T02:45:39.433239Z","end":"2026-09-15T02:45:39.560433Z","steps":["trace[178972094] 'read index received' (duration: 48.798949ms)","trace[178972094] 'applied index is now lower than readState.Index' (duration: 78.393246ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:45:39.560539Z","caller":"traceutil/trace.go:171","msg":"trace[1824435042] transaction","detail":"{read_only:false; response_revision:10027; number_of_response:1; }","duration":"135.112033ms","start":"2026-09-15T02:45:39.425401Z","end":"2026-09-15T02:45:39.560513Z","steps":["trace[1824435042] 'process raft request' (duration: 97.925156ms)","trace[1824435042] 'compare' (duration: 36.93156ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T02:45:39.560701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.416581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:45:39.56077Z","caller":"traceutil/trace.go:171","msg":"trace[1375755323] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:10027; }","duration":"127.546695ms","start":"2026-09-15T02:45:39.433212Z","end":"2026-09-15T02:45:39.560759Z","steps":["trace[1375755323] 'agreement among raft nodes before linearized reading' (duration: 127.37804ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:45:39.598401Z","caller":"traceutil/trace.go:171","msg":"trace[1612738276] transaction","detail":"{read_only:false; response_revision:10029; number_of_response:1; }","duration":"109.447134ms","start":"2026-09-15T02:45:39.488933Z","end":"2026-09-15T02:45:39.59838Z","steps":["trace[1612738276] 'process raft request' (duration: 109.31363ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:45:39.59856Z","caller":"traceutil/trace.go:171","msg":"trace[1072231376] transaction","detail":"{read_only:false; response_revision:10030; number_of_response:1; }","duration":"107.599962ms","start":"2026-09-15T02:45:39.490915Z","end":"2026-09-15T02:45:39.598515Z","steps":["trace[1072231376] 'process raft request' (duration: 107.392217ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:45:39.598441Z","caller":"traceutil/trace.go:171","msg":"trace[69819775] transaction","detail":"{read_only:false; response_revision:10028; number_of_response:1; }","duration":"109.734852ms","start":"2026-09-15T02:45:39.488686Z","end":"2026-09-15T02:45:39.598421Z","steps":["trace[69819775] 'process raft request' (duration: 109.442294ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:45:39.862432Z","caller":"traceutil/trace.go:171","msg":"trace[1061892632] transaction","detail":"{read_only:false; response_revision:10032; number_of_response:1; }","duration":"160.949447ms","start":"2026-09-15T02:45:39.701443Z","end":"2026-09-15T02:45:39.862393Z","steps":["trace[1061892632] 'process raft request' (duration: 155.937048ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:46:20.190438Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7924} {"level":"info","ts":"2026-09-15T02:46:20.277173Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7924,"took":"84.073353ms","hash":2479085929,"current-db-size-bytes":55603200,"current-db-size":"56 MB","current-db-size-in-use-bytes":24928256,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-09-15T02:46:20.277252Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2479085929,"revision":7924,"compact-revision":5514} {"level":"info","ts":"2026-09-15T02:47:12.406073Z","caller":"traceutil/trace.go:171","msg":"trace[1554718393] transaction","detail":"{read_only:false; response_revision:10643; number_of_response:1; }","duration":"101.00183ms","start":"2026-09-15T02:47:12.305039Z","end":"2026-09-15T02:47:12.406041Z","steps":["trace[1554718393] 'process raft request' (duration: 88.014981ms)","trace[1554718393] 'compare' (duration: 12.882647ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:47:12.782008Z","caller":"traceutil/trace.go:171","msg":"trace[330050747] transaction","detail":"{read_only:false; response_revision:10651; number_of_response:1; }","duration":"112.782915ms","start":"2026-09-15T02:47:12.669203Z","end":"2026-09-15T02:47:12.781986Z","steps":["trace[330050747] 'process raft request' (duration: 112.682773ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:47:12.78207Z","caller":"traceutil/trace.go:171","msg":"trace[1376371573] transaction","detail":"{read_only:false; response_revision:10650; number_of_response:1; }","duration":"116.91062ms","start":"2026-09-15T02:47:12.665103Z","end":"2026-09-15T02:47:12.782014Z","steps":["trace[1376371573] 'process raft request' (duration: 103.583272ms)","trace[1376371573] 'compare' (duration: 13.01996ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:47:12.911001Z","caller":"traceutil/trace.go:171","msg":"trace[53261616] transaction","detail":"{read_only:false; response_revision:10654; number_of_response:1; }","duration":"106.350838ms","start":"2026-09-15T02:47:12.804578Z","end":"2026-09-15T02:47:12.910929Z","steps":["trace[53261616] 'process raft request' (duration: 84.73255ms)","trace[53261616] 'compare' (duration: 20.96093ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:47:13.059201Z","caller":"traceutil/trace.go:171","msg":"trace[799187513] transaction","detail":"{read_only:false; response_revision:10655; number_of_response:1; }","duration":"112.445347ms","start":"2026-09-15T02:47:12.94669Z","end":"2026-09-15T02:47:13.059136Z","steps":["trace[799187513] 'process raft request' (duration: 112.253932ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:51:12.830359Z","caller":"traceutil/trace.go:171","msg":"trace[2075758292] transaction","detail":"{read_only:false; response_revision:12414; number_of_response:1; }","duration":"315.699473ms","start":"2026-09-15T02:51:12.514622Z","end":"2026-09-15T02:51:12.830321Z","steps":["trace[2075758292] 'process raft request' (duration: 315.411665ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:51:12.830755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:51:12.514579Z","time spent":"315.94917ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1119,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-15T02:51:20.197992Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10314} {"level":"info","ts":"2026-09-15T02:51:20.299126Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10314,"took":"98.307007ms","hash":1982388370,"current-db-size-bytes":55603200,"current-db-size":"56 MB","current-db-size-in-use-bytes":25645056,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-09-15T02:51:20.299195Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1982388370,"revision":10314,"compact-revision":7924} {"level":"info","ts":"2026-09-15T02:56:20.210289Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12473} {"level":"info","ts":"2026-09-15T02:56:20.294551Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12473,"took":"81.868311ms","hash":501160969,"current-db-size-bytes":55603200,"current-db-size":"56 MB","current-db-size-in-use-bytes":28069888,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-15T02:56:20.294629Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":501160969,"revision":12473,"compact-revision":10314} {"level":"info","ts":"2026-09-15T02:57:59.645142Z","caller":"traceutil/trace.go:171","msg":"trace[974318072] linearizableReadLoop","detail":"{readStateIndex:15644; appliedIndex:15643; }","duration":"219.315139ms","start":"2026-09-15T02:57:59.425801Z","end":"2026-09-15T02:57:59.645116Z","steps":["trace[974318072] 'read index received' (duration: 219.060123ms)","trace[974318072] 'applied index is now lower than readState.Index' (duration: 253.876µs)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:57:59.645315Z","caller":"traceutil/trace.go:171","msg":"trace[1455088975] transaction","detail":"{read_only:false; response_revision:15112; number_of_response:1; }","duration":"225.209482ms","start":"2026-09-15T02:57:59.42009Z","end":"2026-09-15T02:57:59.6453Z","steps":["trace[1455088975] 'process raft request' (duration: 224.786441ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:57:59.645586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.773863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-15T02:57:59.645627Z","caller":"traceutil/trace.go:171","msg":"trace[1976988120] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15112; }","duration":"219.872715ms","start":"2026-09-15T02:57:59.425744Z","end":"2026-09-15T02:57:59.645616Z","steps":["trace[1976988120] 'agreement among raft nodes before linearized reading' (duration: 219.717791ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:57:59.645787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.207144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:57:59.64588Z","caller":"traceutil/trace.go:171","msg":"trace[731307242] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15112; }","duration":"212.356328ms","start":"2026-09-15T02:57:59.433505Z","end":"2026-09-15T02:57:59.645861Z","steps":["trace[731307242] 'agreement among raft nodes before linearized reading' (duration: 212.215324ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:57:59.646032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.022719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-15T02:57:59.646081Z","caller":"traceutil/trace.go:171","msg":"trace[2126902006] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:15112; }","duration":"203.131772ms","start":"2026-09-15T02:57:59.442937Z","end":"2026-09-15T02:57:59.646068Z","steps":["trace[2126902006] 'agreement among raft nodes before linearized reading' (duration: 203.005639ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:58:00.418054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.438956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-15T02:58:00.418111Z","caller":"traceutil/trace.go:171","msg":"trace[1626763631] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:15119; }","duration":"340.55299ms","start":"2026-09-15T02:58:00.077546Z","end":"2026-09-15T02:58:00.418099Z","steps":["trace[1626763631] 'count revisions from in-memory index tree' (duration: 340.355754ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:58:00.418138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:58:00.077524Z","time spent":"340.607771ms","remote":"127.0.0.1:42604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":115,"response size":30,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"info","ts":"2026-09-15T02:58:00.518516Z","caller":"traceutil/trace.go:171","msg":"trace[1639392362] transaction","detail":"{read_only:false; response_revision:15120; number_of_response:1; }","duration":"395.992222ms","start":"2026-09-15T02:58:00.122499Z","end":"2026-09-15T02:58:00.518491Z","steps":["trace[1639392362] 'process raft request' (duration: 395.814847ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:58:00.518692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:58:00.122467Z","time spent":"396.124245ms","remote":"127.0.0.1:42796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-15T02:58:00.562629Z","caller":"traceutil/trace.go:171","msg":"trace[258371924] linearizableReadLoop","detail":"{readStateIndex:15653; appliedIndex:15651; }","duration":"203.955375ms","start":"2026-09-15T02:58:00.358641Z","end":"2026-09-15T02:58:00.562597Z","steps":["trace[258371924] 'read index received' (duration: 159.702393ms)","trace[258371924] 'applied index is now lower than readState.Index' (duration: 44.251971ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:58:00.562663Z","caller":"traceutil/trace.go:171","msg":"trace[1550517285] transaction","detail":"{read_only:false; response_revision:15121; number_of_response:1; }","duration":"395.984931ms","start":"2026-09-15T02:58:00.166653Z","end":"2026-09-15T02:58:00.562638Z","steps":["trace[1550517285] 'process raft request' (duration: 395.770155ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:58:00.562799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.15021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-15T02:58:00.562802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:58:00.166623Z","time spent":"396.095165ms","remote":"127.0.0.1:42796","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-09-15T02:58:00.562841Z","caller":"traceutil/trace.go:171","msg":"trace[226273914] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:15121; }","duration":"204.243213ms","start":"2026-09-15T02:58:00.358583Z","end":"2026-09-15T02:58:00.562826Z","steps":["trace[226273914] 'agreement among raft nodes before linearized reading' (duration: 204.160431ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:58:00.56286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.015296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:58:00.562947Z","caller":"traceutil/trace.go:171","msg":"trace[248197646] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15121; }","duration":"129.139549ms","start":"2026-09-15T02:58:00.433787Z","end":"2026-09-15T02:58:00.562927Z","steps":["trace[248197646] 'agreement among raft nodes before linearized reading' (duration: 128.992785ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:58:10.907371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.768648ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-15T02:58:10.907502Z","caller":"traceutil/trace.go:171","msg":"trace[60274424] transaction","detail":"{read_only:false; response_revision:15295; number_of_response:1; }","duration":"239.576469ms","start":"2026-09-15T02:58:10.667902Z","end":"2026-09-15T02:58:10.907478Z","steps":["trace[60274424] 'process raft request' (duration: 26.606875ms)","trace[60274424] 'compare' (duration: 212.559063ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T02:58:11.336078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.129222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:58:11.336191Z","caller":"traceutil/trace.go:171","msg":"trace[1546397277] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:15296; }","duration":"321.305216ms","start":"2026-09-15T02:58:11.014857Z","end":"2026-09-15T02:58:11.336162Z","steps":["trace[1546397277] 'count revisions from in-memory index tree' (duration: 320.975237ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:58:11.336249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T02:58:11.014838Z","time spent":"321.394379ms","remote":"127.0.0.1:39940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-09-15T02:58:11.336781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.803353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/ovn-controller-default-w2dxl.18d55f30a78dae9f\" ","response":"range_response_count:1 size:783"} {"level":"info","ts":"2026-09-15T02:58:11.336919Z","caller":"traceutil/trace.go:171","msg":"trace[1292210054] range","detail":"{range_begin:/registry/events/openstack/ovn-controller-default-w2dxl.18d55f30a78dae9f; range_end:; response_count:1; response_revision:15296; }","duration":"279.03706ms","start":"2026-09-15T02:58:11.057852Z","end":"2026-09-15T02:58:11.336889Z","steps":["trace[1292210054] 'range keys from in-memory index tree' (duration: 278.604157ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:59:20.24427Z","caller":"traceutil/trace.go:171","msg":"trace[1387224069] transaction","detail":"{read_only:false; response_revision:16212; number_of_response:1; }","duration":"100.728646ms","start":"2026-09-15T02:59:20.143514Z","end":"2026-09-15T02:59:20.244243Z","steps":["trace[1387224069] 'process raft request' (duration: 100.1283ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:59:20.262636Z","caller":"traceutil/trace.go:171","msg":"trace[1906416101] linearizableReadLoop","detail":"{readStateIndex:16772; appliedIndex:16770; }","duration":"111.292389ms","start":"2026-09-15T02:59:20.151306Z","end":"2026-09-15T02:59:20.262599Z","steps":["trace[1906416101] 'read index received' (duration: 92.751995ms)","trace[1906416101] 'applied index is now lower than readState.Index' (duration: 18.539654ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:59:20.263507Z","caller":"traceutil/trace.go:171","msg":"trace[679180050] transaction","detail":"{read_only:false; response_revision:16213; number_of_response:1; }","duration":"115.747051ms","start":"2026-09-15T02:59:20.147698Z","end":"2026-09-15T02:59:20.263445Z","steps":["trace[679180050] 'process raft request' (duration: 114.784405ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:59:20.263617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.299496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:79 size:764178"} {"level":"info","ts":"2026-09-15T02:59:20.263661Z","caller":"traceutil/trace.go:171","msg":"trace[314239733] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:79; response_revision:16214; }","duration":"112.400008ms","start":"2026-09-15T02:59:20.15125Z","end":"2026-09-15T02:59:20.26365Z","steps":["trace[314239733] 'agreement among raft nodes before linearized reading' (duration: 111.432132ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:59:44.216865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.367505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5fd8m\" ","response":"range_response_count:1 size:6441"} {"level":"warn","ts":"2026-09-15T02:59:44.216904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.804651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:59:44.216994Z","caller":"traceutil/trace.go:171","msg":"trace[1176404019] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5fd8m; range_end:; response_count:1; response_revision:16340; }","duration":"182.53801ms","start":"2026-09-15T02:59:44.034426Z","end":"2026-09-15T02:59:44.216964Z","steps":["trace[1176404019] 'range keys from in-memory index tree' (duration: 182.110137ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:59:44.217057Z","caller":"traceutil/trace.go:171","msg":"trace[1368205255] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16340; }","duration":"197.989626ms","start":"2026-09-15T02:59:44.018996Z","end":"2026-09-15T02:59:44.216985Z","steps":["trace[1368205255] 'range keys from in-memory index tree' (duration: 197.700088ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:59:44.21706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.590647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"} {"level":"warn","ts":"2026-09-15T02:59:44.217045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.251076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-metadata\" ","response":"range_response_count:1 size:681"} {"level":"info","ts":"2026-09-15T02:59:44.21713Z","caller":"traceutil/trace.go:171","msg":"trace[1442437876] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16340; }","duration":"175.671009ms","start":"2026-09-15T02:59:44.04144Z","end":"2026-09-15T02:59:44.217111Z","steps":["trace[1442437876] 'range keys from in-memory index tree' (duration: 175.386792ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:59:44.217168Z","caller":"traceutil/trace.go:171","msg":"trace[1318632026] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-metadata; range_end:; response_count:1; response_revision:16340; }","duration":"197.469873ms","start":"2026-09-15T02:59:44.019669Z","end":"2026-09-15T02:59:44.217139Z","steps":["trace[1318632026] 'range keys from in-memory index tree' (duration: 196.998399ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:59:44.217296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.086579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-15T02:59:44.217322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.229555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-09-15T02:59:44.21737Z","caller":"traceutil/trace.go:171","msg":"trace[358911360] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:0; response_revision:16340; }","duration":"198.193522ms","start":"2026-09-15T02:59:44.019154Z","end":"2026-09-15T02:59:44.217348Z","steps":["trace[358911360] 'range keys from in-memory index tree' (duration: 197.986696ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:59:44.217765Z","caller":"traceutil/trace.go:171","msg":"trace[450522907] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16340; }","duration":"197.862933ms","start":"2026-09-15T02:59:44.019551Z","end":"2026-09-15T02:59:44.217414Z","steps":["trace[450522907] 'range keys from in-memory index tree' (duration: 197.05778ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:59:44.730438Z","caller":"traceutil/trace.go:171","msg":"trace[1879042111] transaction","detail":"{read_only:false; response_revision:16342; number_of_response:1; }","duration":"211.351466ms","start":"2026-09-15T02:59:44.519047Z","end":"2026-09-15T02:59:44.730398Z","steps":["trace[1879042111] 'process raft request' (duration: 199.813587ms)","trace[1879042111] 'compare' (duration: 11.126658ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:59:44.730971Z","caller":"traceutil/trace.go:171","msg":"trace[720266149] transaction","detail":"{read_only:false; response_revision:16343; number_of_response:1; }","duration":"211.207491ms","start":"2026-09-15T02:59:44.51974Z","end":"2026-09-15T02:59:44.730947Z","steps":["trace[720266149] 'process raft request' (duration: 211.091018ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:59:44.731101Z","caller":"traceutil/trace.go:171","msg":"trace[555427665] linearizableReadLoop","detail":"{readStateIndex:16907; appliedIndex:16905; }","duration":"209.627158ms","start":"2026-09-15T02:59:44.52143Z","end":"2026-09-15T02:59:44.731058Z","steps":["trace[555427665] 'read index received' (duration: 197.39017ms)","trace[555427665] 'applied index is now lower than readState.Index' (duration: 12.231998ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T02:59:44.731157Z","caller":"traceutil/trace.go:171","msg":"trace[741542989] transaction","detail":"{read_only:false; response_revision:16344; number_of_response:1; }","duration":"206.80346ms","start":"2026-09-15T02:59:44.524291Z","end":"2026-09-15T02:59:44.731094Z","steps":["trace[741542989] 'process raft request' (duration: 206.622645ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:59:44.731325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.35294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:59:44.731393Z","caller":"traceutil/trace.go:171","msg":"trace[226466250] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16344; }","duration":"209.462024ms","start":"2026-09-15T02:59:44.521912Z","end":"2026-09-15T02:59:44.731374Z","steps":["trace[226466250] 'agreement among raft nodes before linearized reading' (duration: 209.34615ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:59:44.731435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.974197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"} {"level":"warn","ts":"2026-09-15T02:59:44.731413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.7095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:59:44.731499Z","caller":"traceutil/trace.go:171","msg":"trace[1682813416] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16344; }","duration":"210.087501ms","start":"2026-09-15T02:59:44.521393Z","end":"2026-09-15T02:59:44.731481Z","steps":["trace[1682813416] 'agreement among raft nodes before linearized reading' (duration: 209.830304ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:59:44.731488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.193051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-zm7q9\" ","response":"range_response_count:1 size:22010"} {"level":"warn","ts":"2026-09-15T02:59:44.73153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.595847ms","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-09-15T02:59:44.731568Z","caller":"traceutil/trace.go:171","msg":"trace[1667128083] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-zm7q9; range_end:; response_count:1; response_revision:16344; }","duration":"134.307185ms","start":"2026-09-15T02:59:44.597234Z","end":"2026-09-15T02:59:44.731541Z","steps":["trace[1667128083] 'agreement among raft nodes before linearized reading' (duration: 134.089909ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:59:44.731591Z","caller":"traceutil/trace.go:171","msg":"trace[2092923768] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:16344; }","duration":"115.69402ms","start":"2026-09-15T02:59:44.615879Z","end":"2026-09-15T02:59:44.731573Z","steps":["trace[2092923768] 'agreement among raft nodes before linearized reading' (duration: 115.490355ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:59:44.731538Z","caller":"traceutil/trace.go:171","msg":"trace[902448188] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:16344; }","duration":"145.879925ms","start":"2026-09-15T02:59:44.585621Z","end":"2026-09-15T02:59:44.7315Z","steps":["trace[902448188] 'agreement among raft nodes before linearized reading' (duration: 145.673619ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:59:44.731665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.177964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"} {"level":"info","ts":"2026-09-15T02:59:44.731697Z","caller":"traceutil/trace.go:171","msg":"trace[306875923] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16344; }","duration":"209.229026ms","start":"2026-09-15T02:59:44.522459Z","end":"2026-09-15T02:59:44.731688Z","steps":["trace[306875923] 'agreement among raft nodes before linearized reading' (duration: 209.143494ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:59:44.731765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.666795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-zm7q9\" ","response":"range_response_count:1 size:22010"} {"level":"info","ts":"2026-09-15T02:59:44.731803Z","caller":"traceutil/trace.go:171","msg":"trace[1086609722] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-zm7q9; range_end:; response_count:1; response_revision:16344; }","duration":"138.736247ms","start":"2026-09-15T02:59:44.593055Z","end":"2026-09-15T02:59:44.731791Z","steps":["trace[1086609722] 'agreement among raft nodes before linearized reading' (duration: 138.515241ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:59:44.732509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.880161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-15T02:59:44.732594Z","caller":"traceutil/trace.go:171","msg":"trace[103258146] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:16344; }","duration":"199.012074ms","start":"2026-09-15T02:59:44.533557Z","end":"2026-09-15T02:59:44.732569Z","steps":["trace[103258146] 'agreement among raft nodes before linearized reading' (duration: 197.956444ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:59:45.613482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.245225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:59:45.613583Z","caller":"traceutil/trace.go:171","msg":"trace[150490980] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:16349; }","duration":"176.42287ms","start":"2026-09-15T02:59:45.437139Z","end":"2026-09-15T02:59:45.613562Z","steps":["trace[150490980] 'range keys from in-memory index tree' (duration: 176.129551ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T02:59:45.614098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.020792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T02:59:45.614226Z","caller":"traceutil/trace.go:171","msg":"trace[1918544034] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:16349; }","duration":"294.237208ms","start":"2026-09-15T02:59:45.319965Z","end":"2026-09-15T02:59:45.614202Z","steps":["trace[1918544034] 'count revisions from in-memory index tree' (duration: 293.904349ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T02:59:45.783424Z","caller":"traceutil/trace.go:171","msg":"trace[1859307422] transaction","detail":"{read_only:false; response_revision:16350; number_of_response:1; }","duration":"108.802389ms","start":"2026-09-15T02:59:45.674589Z","end":"2026-09-15T02:59:45.783392Z","steps":["trace[1859307422] 'process raft request' (duration: 108.581903ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T03:01:20.217694Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14509} {"level":"info","ts":"2026-09-15T03:01:20.303532Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14509,"took":"83.555781ms","hash":4050501408,"current-db-size-bytes":55603200,"current-db-size":"56 MB","current-db-size-in-use-bytes":31588352,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-09-15T03:01:20.303623Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4050501408,"revision":14509,"compact-revision":12473} {"level":"info","ts":"2026-09-15T03:02:57.679015Z","caller":"traceutil/trace.go:171","msg":"trace[1840801788] transaction","detail":"{read_only:false; response_revision:17880; number_of_response:1; }","duration":"102.31312ms","start":"2026-09-15T03:02:57.576681Z","end":"2026-09-15T03:02:57.678994Z","steps":["trace[1840801788] 'process raft request' (duration: 101.749955ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T03:05:34.40634Z","caller":"traceutil/trace.go:171","msg":"trace[2139030984] linearizableReadLoop","detail":"{readStateIndex:19619; appliedIndex:19617; }","duration":"199.408455ms","start":"2026-09-15T03:05:34.206904Z","end":"2026-09-15T03:05:34.406313Z","steps":["trace[2139030984] 'read index received' (duration: 199.290581ms)","trace[2139030984] 'applied index is now lower than readState.Index' (duration: 116.104µs)"],"step_count":2} {"level":"info","ts":"2026-09-15T03:05:34.406394Z","caller":"traceutil/trace.go:171","msg":"trace[14976389] transaction","detail":"{read_only:false; response_revision:18968; number_of_response:1; }","duration":"317.390388ms","start":"2026-09-15T03:05:34.088959Z","end":"2026-09-15T03:05:34.406349Z","steps":["trace[14976389] 'process raft request' (duration: 317.1011ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T03:05:34.406556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T03:05:34.088936Z","time spent":"317.542142ms","remote":"127.0.0.1:42796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T03:05:34.406585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.665071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-msjd9\" ","response":"range_response_count:1 size:20657"} {"level":"info","ts":"2026-09-15T03:05:34.406621Z","caller":"traceutil/trace.go:171","msg":"trace[1787189602] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-msjd9; range_end:; response_count:1; response_revision:18969; }","duration":"199.757194ms","start":"2026-09-15T03:05:34.206851Z","end":"2026-09-15T03:05:34.406608Z","steps":["trace[1787189602] 'agreement among raft nodes before linearized reading' (duration: 199.595499ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T03:05:34.406718Z","caller":"traceutil/trace.go:171","msg":"trace[1923780288] transaction","detail":"{read_only:false; response_revision:18969; number_of_response:1; }","duration":"317.695796ms","start":"2026-09-15T03:05:34.088993Z","end":"2026-09-15T03:05:34.406689Z","steps":["trace[1923780288] 'process raft request' (duration: 317.272184ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T03:05:34.406862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T03:05:34.088977Z","time spent":"317.81114ms","remote":"127.0.0.1:42796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-15T03:05:34.733708Z","caller":"traceutil/trace.go:171","msg":"trace[1282287040] linearizableReadLoop","detail":"{readStateIndex:19621; appliedIndex:19620; }","duration":"294.192537ms","start":"2026-09-15T03:05:34.439483Z","end":"2026-09-15T03:05:34.733675Z","steps":["trace[1282287040] 'read index received' (duration: 201.783461ms)","trace[1282287040] 'applied index is now lower than readState.Index' (duration: 92.407396ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T03:05:34.73389Z","caller":"traceutil/trace.go:171","msg":"trace[2121344697] transaction","detail":"{read_only:false; response_revision:18971; number_of_response:1; }","duration":"304.946964ms","start":"2026-09-15T03:05:34.428902Z","end":"2026-09-15T03:05:34.733849Z","steps":["trace[2121344697] 'process raft request' (duration: 212.275771ms)","trace[2121344697] 'compare' (duration: 92.190749ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T03:05:34.733947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.441623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-15T03:05:34.734003Z","caller":"traceutil/trace.go:171","msg":"trace[1089289051] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18971; }","duration":"294.550406ms","start":"2026-09-15T03:05:34.439436Z","end":"2026-09-15T03:05:34.733987Z","steps":["trace[1089289051] 'agreement among raft nodes before linearized reading' (duration: 294.410713ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T03:05:34.73403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T03:05:34.428876Z","time spent":"305.075337ms","remote":"127.0.0.1:42690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20774,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T03:05:34.734135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.235621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-k8bq8\" ","response":"range_response_count:1 size:9709"} {"level":"warn","ts":"2026-09-15T03:05:34.7342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.047894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-15T03:05:34.734238Z","caller":"traceutil/trace.go:171","msg":"trace[76350841] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:18971; }","duration":"144.148977ms","start":"2026-09-15T03:05:34.590077Z","end":"2026-09-15T03:05:34.734226Z","steps":["trace[76350841] 'agreement among raft nodes before linearized reading' (duration: 144.082015ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T03:05:34.734235Z","caller":"traceutil/trace.go:171","msg":"trace[2047484265] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-k8bq8; range_end:; response_count:1; response_revision:18971; }","duration":"246.408835ms","start":"2026-09-15T03:05:34.487801Z","end":"2026-09-15T03:05:34.73421Z","steps":["trace[2047484265] 'agreement among raft nodes before linearized reading' (duration: 246.090657ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T03:05:34.73439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.588608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-09-15T03:05:34.734421Z","caller":"traceutil/trace.go:171","msg":"trace[1736222761] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:18971; }","duration":"204.64968ms","start":"2026-09-15T03:05:34.529762Z","end":"2026-09-15T03:05:34.734412Z","steps":["trace[1736222761] 'agreement among raft nodes before linearized reading' (duration: 204.554167ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T03:05:35.383428Z","caller":"traceutil/trace.go:171","msg":"trace[229226046] transaction","detail":"{read_only:false; response_revision:18973; number_of_response:1; }","duration":"643.597671ms","start":"2026-09-15T03:05:34.73978Z","end":"2026-09-15T03:05:35.383378Z","steps":["trace[229226046] 'process raft request' (duration: 631.296841ms)","trace[229226046] 'compare' (duration: 11.434416ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T03:05:35.383493Z","caller":"traceutil/trace.go:171","msg":"trace[126089605] transaction","detail":"{read_only:false; response_revision:18974; number_of_response:1; }","duration":"643.58873ms","start":"2026-09-15T03:05:34.739843Z","end":"2026-09-15T03:05:35.383432Z","steps":["trace[126089605] 'process raft request' (duration: 643.396255ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T03:05:35.383602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T03:05:34.73977Z","time spent":"643.749785ms","remote":"127.0.0.1:42796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-15T03:05:35.383554Z","caller":"traceutil/trace.go:171","msg":"trace[1473190364] transaction","detail":"{read_only:false; response_revision:18975; number_of_response:1; }","duration":"641.678027ms","start":"2026-09-15T03:05:34.74181Z","end":"2026-09-15T03:05:35.383488Z","steps":["trace[1473190364] 'process raft request' (duration: 641.553074ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T03:05:35.383696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T03:05:34.739808Z","time spent":"643.790666ms","remote":"127.0.0.1:42796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T03:05:35.383762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T03:05:34.74178Z","time spent":"641.873252ms","remote":"127.0.0.1:42796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-15T03:05:35.383777Z","caller":"traceutil/trace.go:171","msg":"trace[199855900] transaction","detail":"{read_only:false; response_revision:18976; number_of_response:1; }","duration":"631.748712ms","start":"2026-09-15T03:05:34.751984Z","end":"2026-09-15T03:05:35.383733Z","steps":["trace[199855900] 'process raft request' (duration: 631.425663ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T03:05:35.38392Z","caller":"traceutil/trace.go:171","msg":"trace[416686615] linearizableReadLoop","detail":"{readStateIndex:19627; appliedIndex:19622; }","duration":"271.004306ms","start":"2026-09-15T03:05:35.112874Z","end":"2026-09-15T03:05:35.383878Z","steps":["trace[416686615] 'read index received' (duration: 257.741599ms)","trace[416686615] 'applied index is now lower than readState.Index' (duration: 13.260997ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T03:05:35.383971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T03:05:34.751956Z","time spent":"631.919507ms","remote":"127.0.0.1:42796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-15T03:05:35.384015Z","caller":"traceutil/trace.go:171","msg":"trace[1594885254] transaction","detail":"{read_only:false; response_revision:18977; number_of_response:1; }","duration":"629.592622ms","start":"2026-09-15T03:05:34.754375Z","end":"2026-09-15T03:05:35.383968Z","steps":["trace[1594885254] 'process raft request' (duration: 629.223412ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T03:05:35.384251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T03:05:34.754332Z","time spent":"629.820708ms","remote":"127.0.0.1:42690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13036,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T03:05:35.384293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.589339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:702"} {"level":"warn","ts":"2026-09-15T03:05:35.384289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.405746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"warn","ts":"2026-09-15T03:05:35.384324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.653614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:702"} {"level":"info","ts":"2026-09-15T03:05:35.384353Z","caller":"traceutil/trace.go:171","msg":"trace[1645649576] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18977; }","duration":"259.662821ms","start":"2026-09-15T03:05:35.124665Z","end":"2026-09-15T03:05:35.384328Z","steps":["trace[1645649576] 'agreement among raft nodes before linearized reading' (duration: 259.513237ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T03:05:35.384381Z","caller":"traceutil/trace.go:171","msg":"trace[1578639775] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18977; }","duration":"271.508239ms","start":"2026-09-15T03:05:35.112831Z","end":"2026-09-15T03:05:35.38434Z","steps":["trace[1578639775] 'agreement among raft nodes before linearized reading' (duration: 271.247922ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T03:05:35.384384Z","caller":"traceutil/trace.go:171","msg":"trace[205681240] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18977; }","duration":"134.752017ms","start":"2026-09-15T03:05:35.24961Z","end":"2026-09-15T03:05:35.384362Z","steps":["trace[205681240] 'agreement among raft nodes before linearized reading' (duration: 134.572602ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T03:06:08.908023Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d346c241c42fcdea","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-15T03:06:08.915046Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-09-15T03:06:08.915375Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-09-15T03:06:20.225723Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16984} {"level":"info","ts":"2026-09-15T03:06:20.335808Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16984,"took":"106.193677ms","hash":2983002882,"current-db-size-bytes":55603200,"current-db-size":"56 MB","current-db-size-in-use-bytes":33284096,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-09-15T03:06:20.335882Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2983002882,"revision":16984,"compact-revision":14509} {"level":"info","ts":"2026-09-15T03:11:20.233083Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19412} {"level":"info","ts":"2026-09-15T03:11:20.355152Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19412,"took":"118.498019ms","hash":474253563,"current-db-size-bytes":55603200,"current-db-size":"56 MB","current-db-size-in-use-bytes":30539776,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-09-15T03:11:20.355305Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":474253563,"revision":19412,"compact-revision":16984} {"level":"info","ts":"2026-09-15T03:11:47.622165Z","caller":"traceutil/trace.go:171","msg":"trace[957160700] transaction","detail":"{read_only:false; response_revision:21831; number_of_response:1; }","duration":"102.851776ms","start":"2026-09-15T03:11:47.519292Z","end":"2026-09-15T03:11:47.622144Z","steps":["trace[957160700] 'process raft request' (duration: 102.453316ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T03:11:53.196272Z","caller":"traceutil/trace.go:171","msg":"trace[226354379] transaction","detail":"{read_only:false; response_revision:21857; number_of_response:1; }","duration":"223.153174ms","start":"2026-09-15T03:11:52.973094Z","end":"2026-09-15T03:11:53.196247Z","steps":["trace[226354379] 'process raft request' (duration: 222.99803ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T03:11:53.550157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.01092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-15T03:11:53.550249Z","caller":"traceutil/trace.go:171","msg":"trace[860927577] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:21857; }","duration":"172.164014ms","start":"2026-09-15T03:11:53.378064Z","end":"2026-09-15T03:11:53.550228Z","steps":["trace[860927577] 'count revisions from in-memory index tree' (duration: 171.903867ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T03:11:53.550227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.434432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-15T03:11:53.550327Z","caller":"traceutil/trace.go:171","msg":"trace[1628080233] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21857; }","duration":"116.579846ms","start":"2026-09-15T03:11:53.433727Z","end":"2026-09-15T03:11:53.550307Z","steps":["trace[1628080233] 'range keys from in-memory index tree' (duration: 116.3366ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T03:11:53.762508Z","caller":"traceutil/trace.go:171","msg":"trace[37975357] transaction","detail":"{read_only:false; response_revision:21858; number_of_response:1; }","duration":"105.579092ms","start":"2026-09-15T03:11:53.656862Z","end":"2026-09-15T03:11:53.762441Z","steps":["trace[37975357] 'process raft request' (duration: 105.223541ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T03:11:54.14184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.10781ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-15T03:11:54.142028Z","caller":"traceutil/trace.go:171","msg":"trace[949877956] transaction","detail":"{read_only:false; response_revision:21861; number_of_response:1; }","duration":"226.685472ms","start":"2026-09-15T03:11:53.915326Z","end":"2026-09-15T03:11:54.142011Z","steps":["trace[949877956] 'process raft request' (duration: 226.630011ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T03:11:54.142138Z","caller":"traceutil/trace.go:171","msg":"trace[1913632887] linearizableReadLoop","detail":"{readStateIndex:22605; appliedIndex:22604; }","duration":"379.79029ms","start":"2026-09-15T03:11:53.762317Z","end":"2026-09-15T03:11:54.142108Z","steps":["trace[1913632887] 'read index received' (duration: 193.379462ms)","trace[1913632887] 'applied index is now lower than readState.Index' (duration: 186.407108ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T03:11:54.14243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.57181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-09-15T03:11:54.142498Z","caller":"traceutil/trace.go:171","msg":"trace[324094972] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21861; }","duration":"449.671302ms","start":"2026-09-15T03:11:53.692804Z","end":"2026-09-15T03:11:54.142476Z","steps":["trace[324094972] 'agreement among raft nodes before linearized reading' (duration: 449.453276ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T03:11:54.14219Z","caller":"traceutil/trace.go:171","msg":"trace[2125884444] transaction","detail":"{read_only:false; response_revision:21860; number_of_response:1; }","duration":"375.11765ms","start":"2026-09-15T03:11:53.767065Z","end":"2026-09-15T03:11:54.142183Z","steps":["trace[2125884444] 'process raft request' (duration: 374.859393ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T03:11:54.142548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T03:11:53.692792Z","time spent":"449.743785ms","remote":"127.0.0.1:42796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-09-15T03:11:54.142595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.30531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-09-15T03:11:54.142624Z","caller":"traceutil/trace.go:171","msg":"trace[1638488029] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:21861; }","duration":"476.394042ms","start":"2026-09-15T03:11:53.666223Z","end":"2026-09-15T03:11:54.142617Z","steps":["trace[1638488029] 'agreement among raft nodes before linearized reading' (duration: 476.291179ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T03:11:54.142647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T03:11:53.666191Z","time spent":"476.451434ms","remote":"127.0.0.1:42796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-09-15T03:11:54.14216Z","caller":"traceutil/trace.go:171","msg":"trace[1691767286] transaction","detail":"{read_only:false; response_revision:21859; number_of_response:1; }","duration":"403.67235ms","start":"2026-09-15T03:11:53.738438Z","end":"2026-09-15T03:11:54.14211Z","steps":["trace[1691767286] 'process raft request' (duration: 217.237742ms)","trace[1691767286] 'compare' (duration: 185.989966ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T03:11:54.142714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T03:11:53.767035Z","time spent":"375.555482ms","remote":"127.0.0.1:42796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T03:11:54.142938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T03:11:53.738404Z","time spent":"404.287067ms","remote":"127.0.0.1:42796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T03:11:54.497414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.810076ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-15T03:11:54.497651Z","caller":"traceutil/trace.go:171","msg":"trace[310666566] transaction","detail":"{read_only:false; response_revision:21862; number_of_response:1; }","duration":"502.68727ms","start":"2026-09-15T03:11:53.994936Z","end":"2026-09-15T03:11:54.497623Z","steps":["trace[310666566] 'process raft request' (duration: 395.549585ms)","trace[310666566] 'compare' (duration: 106.502977ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T03:11:54.497786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T03:11:53.994909Z","time spent":"502.801153ms","remote":"127.0.0.1:42796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-15T03:11:54.497812Z","caller":"traceutil/trace.go:171","msg":"trace[861243312] transaction","detail":"{read_only:false; response_revision:21865; number_of_response:1; }","duration":"387.518513ms","start":"2026-09-15T03:11:54.11027Z","end":"2026-09-15T03:11:54.497788Z","steps":["trace[861243312] 'process raft request' (duration: 387.447971ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T03:11:54.497845Z","caller":"traceutil/trace.go:171","msg":"trace[559290595] transaction","detail":"{read_only:false; response_revision:21863; number_of_response:1; }","duration":"469.225384ms","start":"2026-09-15T03:11:54.028575Z","end":"2026-09-15T03:11:54.4978Z","steps":["trace[559290595] 'process raft request' (duration: 468.967986ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T03:11:54.497915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T03:11:54.11024Z","time spent":"387.624435ms","remote":"127.0.0.1:42796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-15T03:11:54.497947Z","caller":"traceutil/trace.go:171","msg":"trace[1614932] transaction","detail":"{read_only:false; response_revision:21864; number_of_response:1; }","duration":"430.026889ms","start":"2026-09-15T03:11:54.067774Z","end":"2026-09-15T03:11:54.497801Z","steps":["trace[1614932] 'process raft request' (duration: 429.891085ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T03:11:54.498085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T03:11:54.028553Z","time spent":"469.395819ms","remote":"127.0.0.1:42796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T03:11:54.49812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T03:11:54.06776Z","time spent":"430.288666ms","remote":"127.0.0.1:42796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T03:11:54.884517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.843118ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-15T03:11:54.884746Z","caller":"traceutil/trace.go:171","msg":"trace[731790786] transaction","detail":"{read_only:false; response_revision:21867; number_of_response:1; }","duration":"737.452297ms","start":"2026-09-15T03:11:54.147279Z","end":"2026-09-15T03:11:54.884731Z","steps":["trace[731790786] 'process raft request' (duration: 737.329783ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T03:11:54.884808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T03:11:54.147259Z","time spent":"737.522468ms","remote":"127.0.0.1:42796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-15T03:11:54.884796Z","caller":"traceutil/trace.go:171","msg":"trace[1193685009] transaction","detail":"{read_only:false; response_revision:21866; number_of_response:1; }","duration":"766.724857ms","start":"2026-09-15T03:11:54.118033Z","end":"2026-09-15T03:11:54.884758Z","steps":["trace[1193685009] 'process raft request' (duration: 526.575841ms)","trace[1193685009] 'compare' (duration: 239.680113ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T03:11:54.884952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T03:11:54.118007Z","time spent":"766.85979ms","remote":"127.0.0.1:42796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-15T03:11:54.885569Z","caller":"traceutil/trace.go:171","msg":"trace[937990049] linearizableReadLoop","detail":"{readStateIndex:22612; appliedIndex:22607; }","duration":"743.327749ms","start":"2026-09-15T03:11:54.142231Z","end":"2026-09-15T03:11:54.885558Z","steps":["trace[937990049] 'read index received' (duration: 248.365084ms)","trace[937990049] 'applied index is now lower than readState.Index' (duration: 494.961665ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T03:11:54.885697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.038377973s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.81\" ","response":"range_response_count:1 size:137"} {"level":"info","ts":"2026-09-15T03:11:54.885743Z","caller":"traceutil/trace.go:171","msg":"trace[1638947925] range","detail":"{range_begin:/registry/masterleases/162.253.55.81; range_end:; response_count:1; response_revision:21868; }","duration":"1.038477537s","start":"2026-09-15T03:11:53.847256Z","end":"2026-09-15T03:11:54.885734Z","steps":["trace[1638947925] 'agreement among raft nodes before linearized reading' (duration: 1.038341472s)"],"step_count":1} {"level":"warn","ts":"2026-09-15T03:11:54.88577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T03:11:53.847231Z","time spent":"1.038531378s","remote":"127.0.0.1:42526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":160,"request content":"key:\"/registry/masterleases/162.253.55.81\" "} {"level":"info","ts":"2026-09-15T03:11:54.885962Z","caller":"traceutil/trace.go:171","msg":"trace[1571769910] transaction","detail":"{read_only:false; response_revision:21868; number_of_response:1; }","duration":"737.929251ms","start":"2026-09-15T03:11:54.148008Z","end":"2026-09-15T03:11:54.885938Z","steps":["trace[1571769910] 'process raft request' (duration: 736.669605ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T03:11:54.886515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T03:11:54.147962Z","time spent":"738.388733ms","remote":"127.0.0.1:42796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T03:11:55.255573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.241158ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"warn","ts":"2026-09-15T03:11:55.255926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T03:11:54.886853Z","time spent":"369.067042ms","remote":"127.0.0.1:42526","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-09-15T03:15:57.201411Z","caller":"traceutil/trace.go:171","msg":"trace[263059315] transaction","detail":"{read_only:false; response_revision:24366; number_of_response:1; }","duration":"154.236008ms","start":"2026-09-15T03:15:57.047151Z","end":"2026-09-15T03:15:57.201387Z","steps":["trace[263059315] 'process raft request' (duration: 154.085254ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T03:15:57.25699Z","caller":"traceutil/trace.go:171","msg":"trace[1531033337] transaction","detail":"{read_only:false; response_revision:24367; number_of_response:1; }","duration":"184.512865ms","start":"2026-09-15T03:15:57.072457Z","end":"2026-09-15T03:15:57.25697Z","steps":["trace[1531033337] 'process raft request' (duration: 183.540538ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T03:15:57.642201Z","caller":"traceutil/trace.go:171","msg":"trace[1046228631] linearizableReadLoop","detail":"{readStateIndex:25185; appliedIndex:25184; }","duration":"280.246865ms","start":"2026-09-15T03:15:57.361925Z","end":"2026-09-15T03:15:57.642172Z","steps":["trace[1046228631] 'read index received' (duration: 278.539658ms)","trace[1046228631] 'applied index is now lower than readState.Index' (duration: 1.705347ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T03:15:57.64221Z","caller":"traceutil/trace.go:171","msg":"trace[126526257] transaction","detail":"{read_only:false; response_revision:24368; number_of_response:1; }","duration":"298.111519ms","start":"2026-09-15T03:15:57.344066Z","end":"2026-09-15T03:15:57.642177Z","steps":["trace[126526257] 'process raft request' (duration: 296.379542ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T03:15:57.642479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.530902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" ","response":"range_response_count:1 size:626"} {"level":"info","ts":"2026-09-15T03:15:57.642586Z","caller":"traceutil/trace.go:171","msg":"trace[594502161] range","detail":"{range_begin:/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi; range_end:; response_count:1; response_revision:24368; }","duration":"280.725158ms","start":"2026-09-15T03:15:57.361833Z","end":"2026-09-15T03:15:57.642558Z","steps":["trace[594502161] 'agreement among raft nodes before linearized reading' (duration: 280.45021ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T03:15:57.643441Z","caller":"traceutil/trace.go:171","msg":"trace[633443643] transaction","detail":"{read_only:false; response_revision:24369; number_of_response:1; }","duration":"213.103537ms","start":"2026-09-15T03:15:57.430308Z","end":"2026-09-15T03:15:57.643412Z","steps":["trace[633443643] 'process raft request' (duration: 212.876681ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T03:15:57.643721Z","caller":"traceutil/trace.go:171","msg":"trace[500249170] transaction","detail":"{read_only:false; response_revision:24370; number_of_response:1; }","duration":"210.525546ms","start":"2026-09-15T03:15:57.433162Z","end":"2026-09-15T03:15:57.643687Z","steps":["trace[500249170] 'process raft request' (duration: 210.174886ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T03:15:57.643754Z","caller":"traceutil/trace.go:171","msg":"trace[444075113] transaction","detail":"{read_only:false; response_revision:24371; number_of_response:1; }","duration":"209.902689ms","start":"2026-09-15T03:15:57.433828Z","end":"2026-09-15T03:15:57.64373Z","steps":["trace[444075113] 'process raft request' (duration: 209.766345ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T03:15:57.643799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.344251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-09-15T03:15:57.643865Z","caller":"traceutil/trace.go:171","msg":"trace[2116724468] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24371; }","duration":"253.441684ms","start":"2026-09-15T03:15:57.390408Z","end":"2026-09-15T03:15:57.643849Z","steps":["trace[2116724468] 'agreement among raft nodes before linearized reading' (duration: 253.28551ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T03:15:57.643915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.179726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-15T03:15:57.643947Z","caller":"traceutil/trace.go:171","msg":"trace[1946331804] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24371; }","duration":"210.240417ms","start":"2026-09-15T03:15:57.433695Z","end":"2026-09-15T03:15:57.643936Z","steps":["trace[1946331804] 'agreement among raft nodes before linearized reading' (duration: 210.163475ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T03:15:57.643987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.828967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-15T03:15:57.644035Z","caller":"traceutil/trace.go:171","msg":"trace[471184087] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:24371; }","duration":"243.894069ms","start":"2026-09-15T03:15:57.400126Z","end":"2026-09-15T03:15:57.64402Z","steps":["trace[471184087] 'agreement among raft nodes before linearized reading' (duration: 243.797686ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T03:15:57.644068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.659409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-15T03:15:57.644234Z","caller":"traceutil/trace.go:171","msg":"trace[1378945788] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24371; }","duration":"180.792203ms","start":"2026-09-15T03:15:57.463374Z","end":"2026-09-15T03:15:57.644166Z","steps":["trace[1378945788] 'agreement among raft nodes before linearized reading' (duration: 180.34525ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T03:16:20.242155Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21692} {"level":"info","ts":"2026-09-15T03:16:20.35975Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21692,"took":"114.051816ms","hash":2951125496,"current-db-size-bytes":55603200,"current-db-size":"56 MB","current-db-size-in-use-bytes":42496000,"current-db-size-in-use":"42 MB"} {"level":"info","ts":"2026-09-15T03:16:20.359818Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2951125496,"revision":21692,"compact-revision":19412} {"level":"info","ts":"2026-09-15T03:20:05.514065Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006afa.wal"} {"level":"info","ts":"2026-09-15T03:21:20.249832Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24594} {"level":"info","ts":"2026-09-15T03:21:20.405642Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24594,"took":"152.057774ms","hash":286126846,"current-db-size-bytes":56446976,"current-db-size":"56 MB","current-db-size-in-use-bytes":34357248,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-09-15T03:21:20.40571Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":286126846,"revision":24594,"compact-revision":21692} {"level":"info","ts":"2026-09-15T03:25:47.480756Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d346c241c42fcdea","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-15T03:25:47.487325Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-09-15T03:25:47.487512Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-09-15T03:26:20.255606Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27069} {"level":"info","ts":"2026-09-15T03:26:20.375042Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27069,"took":"116.648969ms","hash":1102231323,"current-db-size-bytes":56446976,"current-db-size":"56 MB","current-db-size-in-use-bytes":31391744,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-09-15T03:26:20.375105Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1102231323,"revision":27069,"compact-revision":24594}