{"level":"warn","ts":"2026-05-21T15:28:05.144095Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-21T15:28:05.144197Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.240:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.240:2380","--initial-cluster=instance=https://199.19.213.240:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.240:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.240:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-21T15:28:05.144283Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-21T15:28:05.144301Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.240:2380"]} {"level":"info","ts":"2026-05-21T15:28:05.144328Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-21T15:28:05.145148Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.240:2379"]} {"level":"info","ts":"2026-05-21T15:28:05.145269Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.240:2380"],"listen-peer-urls":["https://199.19.213.240:2380"],"advertise-client-urls":["https://199.19.213.240:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.240:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.240:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-21T15:28:05.149615Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.079003ms"} {"level":"info","ts":"2026-05-21T15:28:05.156748Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"65ae7913d9d30912","cluster-id":"74cb0f8fbd7d5970"} {"level":"info","ts":"2026-05-21T15:28:05.156811Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"65ae7913d9d30912 switched to configuration voters=()"} {"level":"info","ts":"2026-05-21T15:28:05.156828Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"65ae7913d9d30912 became follower at term 0"} {"level":"info","ts":"2026-05-21T15:28:05.156838Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 65ae7913d9d30912 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-21T15:28:05.156848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"65ae7913d9d30912 became follower at term 1"} {"level":"info","ts":"2026-05-21T15:28:05.156881Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"65ae7913d9d30912 switched to configuration voters=(7326926769944201490)"} {"level":"warn","ts":"2026-05-21T15:28:05.16925Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-21T15:28:05.170225Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-21T15:28:05.1709Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-21T15:28:05.172743Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"65ae7913d9d30912","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-21T15:28:05.176387Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-21T15:28:05.176514Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-21T15:28:05.176525Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-21T15:28:05.176618Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"65ae7913d9d30912","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-21T15:28:05.177716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"65ae7913d9d30912 switched to configuration voters=(7326926769944201490)"} {"level":"info","ts":"2026-05-21T15:28:05.177896Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"74cb0f8fbd7d5970","local-member-id":"65ae7913d9d30912","added-peer-id":"65ae7913d9d30912","added-peer-peer-urls":["https://199.19.213.240:2380"]} {"level":"info","ts":"2026-05-21T15:28:05.177973Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.240:2380"} {"level":"info","ts":"2026-05-21T15:28:05.177992Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.240:2380"} {"level":"info","ts":"2026-05-21T15:28:05.177949Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-21T15:28:05.178401Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"65ae7913d9d30912","initial-advertise-peer-urls":["https://199.19.213.240:2380"],"listen-peer-urls":["https://199.19.213.240:2380"],"advertise-client-urls":["https://199.19.213.240:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.240:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-21T15:28:05.178465Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-21T15:28:05.257467Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"65ae7913d9d30912 is starting a new election at term 1"} {"level":"info","ts":"2026-05-21T15:28:05.257578Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"65ae7913d9d30912 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-21T15:28:05.257614Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"65ae7913d9d30912 received MsgPreVoteResp from 65ae7913d9d30912 at term 1"} {"level":"info","ts":"2026-05-21T15:28:05.257651Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"65ae7913d9d30912 became candidate at term 2"} {"level":"info","ts":"2026-05-21T15:28:05.257666Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"65ae7913d9d30912 received MsgVoteResp from 65ae7913d9d30912 at term 2"} {"level":"info","ts":"2026-05-21T15:28:05.25774Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"65ae7913d9d30912 became leader at term 2"} {"level":"info","ts":"2026-05-21T15:28:05.25776Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 65ae7913d9d30912 elected leader 65ae7913d9d30912 at term 2"} {"level":"info","ts":"2026-05-21T15:28:05.259129Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-21T15:28:05.259904Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-21T15:28:05.259907Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"65ae7913d9d30912","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.240:2379]}","request-path":"/0/members/65ae7913d9d30912/attributes","cluster-id":"74cb0f8fbd7d5970","publish-timeout":"7s"} {"level":"info","ts":"2026-05-21T15:28:05.259951Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-21T15:28:05.260161Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-21T15:28:05.260266Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-21T15:28:05.261712Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-21T15:28:05.264117Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"74cb0f8fbd7d5970","local-member-id":"65ae7913d9d30912","cluster-version":"3.5"} {"level":"info","ts":"2026-05-21T15:28:05.264234Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-21T15:28:05.264277Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-21T15:28:05.264316Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.240:2379"} {"level":"info","ts":"2026-05-21T15:28:51.418147Z","caller":"traceutil/trace.go:171","msg":"trace[1615352398] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:661; }","duration":"105.367396ms","start":"2026-05-21T15:28:51.312745Z","end":"2026-05-21T15:28:51.418113Z","steps":["trace[1615352398] 'read index received' (duration: 103.090141ms)","trace[1615352398] 'applied index is now lower than readState.Index' (duration: 2.275765ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T15:28:51.418791Z","caller":"traceutil/trace.go:171","msg":"trace[1751262104] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"253.241928ms","start":"2026-05-21T15:28:51.164969Z","end":"2026-05-21T15:28:51.41821Z","steps":["trace[1751262104] 'process raft request' (duration: 251.630857ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:28:51.418857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.11028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T15:28:51.419601Z","caller":"traceutil/trace.go:171","msg":"trace[347946365] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:635; }","duration":"106.919226ms","start":"2026-05-21T15:28:51.31265Z","end":"2026-05-21T15:28:51.419569Z","steps":["trace[347946365] 'agreement among raft nodes before linearized reading' (duration: 105.642081ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T15:28:51.626688Z","caller":"traceutil/trace.go:171","msg":"trace[619892198] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:663; }","duration":"136.475082ms","start":"2026-05-21T15:28:51.49018Z","end":"2026-05-21T15:28:51.626655Z","steps":["trace[619892198] 'read index received' (duration: 136.289058ms)","trace[619892198] 'applied index is now lower than readState.Index' (duration: 184.604µs)"],"step_count":2} {"level":"info","ts":"2026-05-21T15:28:51.626828Z","caller":"traceutil/trace.go:171","msg":"trace[1101545303] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"145.54941ms","start":"2026-05-21T15:28:51.481219Z","end":"2026-05-21T15:28:51.626768Z","steps":["trace[1101545303] 'process raft request' (duration: 145.249244ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:28:51.627092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.85598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-21T15:28:51.627148Z","caller":"traceutil/trace.go:171","msg":"trace[2116253969] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:637; }","duration":"137.004343ms","start":"2026-05-21T15:28:51.490126Z","end":"2026-05-21T15:28:51.62713Z","steps":["trace[2116253969] 'agreement among raft nodes before linearized reading' (duration: 136.713446ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:28:51.627184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.348746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-21T15:28:51.627262Z","caller":"traceutil/trace.go:171","msg":"trace[1361156689] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:637; }","duration":"126.490689ms","start":"2026-05-21T15:28:51.500749Z","end":"2026-05-21T15:28:51.62724Z","steps":["trace[1361156689] 'agreement among raft nodes before linearized reading' (duration: 126.141581ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:28:51.990495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.957506ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-21T15:28:51.990608Z","caller":"traceutil/trace.go:171","msg":"trace[1479745284] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"358.803727ms","start":"2026-05-21T15:28:51.631787Z","end":"2026-05-21T15:28:51.990591Z","steps":["trace[1479745284] 'process raft request' (duration: 169.304252ms)","trace[1479745284] 'compare' (duration: 187.759722ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T15:28:51.990839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:28:51.631763Z","time spent":"358.876749ms","remote":"127.0.0.1:57560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T15:28:51.990908Z","caller":"traceutil/trace.go:171","msg":"trace[1990633644] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:664; }","duration":"351.354462ms","start":"2026-05-21T15:28:51.639519Z","end":"2026-05-21T15:28:51.990873Z","steps":["trace[1990633644] 'read index received' (duration: 161.50828ms)","trace[1990633644] 'applied index is now lower than readState.Index' (duration: 189.844912ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T15:28:51.990996Z","caller":"traceutil/trace.go:171","msg":"trace[1639400368] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"358.149144ms","start":"2026-05-21T15:28:51.632768Z","end":"2026-05-21T15:28:51.990917Z","steps":["trace[1639400368] 'process raft request' (duration: 357.884089ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T15:28:51.991046Z","caller":"traceutil/trace.go:171","msg":"trace[250839374] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"356.354749ms","start":"2026-05-21T15:28:51.634652Z","end":"2026-05-21T15:28:51.991007Z","steps":["trace[250839374] 'process raft request' (duration: 356.166575ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:28:51.991187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.645069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T15:28:51.991239Z","caller":"traceutil/trace.go:171","msg":"trace[360707930] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:640; }","duration":"351.760671ms","start":"2026-05-21T15:28:51.639461Z","end":"2026-05-21T15:28:51.991222Z","steps":["trace[360707930] 'agreement among raft nodes before linearized reading' (duration: 351.561726ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:28:51.991281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:28:51.63944Z","time spent":"351.832222ms","remote":"127.0.0.1:57524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-05-21T15:28:51.99129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:28:51.632739Z","time spent":"358.402189ms","remote":"127.0.0.1:57560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T15:28:51.991376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:28:51.634624Z","time spent":"356.581505ms","remote":"127.0.0.1:57560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T15:28:51.991573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.321972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-21T15:28:51.991692Z","caller":"traceutil/trace.go:171","msg":"trace[1991455616] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:640; }","duration":"231.513876ms","start":"2026-05-21T15:28:51.76016Z","end":"2026-05-21T15:28:51.991674Z","steps":["trace[1991455616] 'agreement among raft nodes before linearized reading' (duration: 231.22723ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:28:51.991941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.609068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jd2ng\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-21T15:28:51.992009Z","caller":"traceutil/trace.go:171","msg":"trace[1625149006] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jd2ng; range_end:; response_count:1; response_revision:640; }","duration":"250.045416ms","start":"2026-05-21T15:28:51.741948Z","end":"2026-05-21T15:28:51.991993Z","steps":["trace[1625149006] 'agreement among raft nodes before linearized reading' (duration: 249.365403ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T15:29:48.451414Z","caller":"traceutil/trace.go:171","msg":"trace[827801329] linearizableReadLoop","detail":"{readStateIndex:1282; appliedIndex:1281; }","duration":"154.637154ms","start":"2026-05-21T15:29:48.29672Z","end":"2026-05-21T15:29:48.451357Z","steps":["trace[827801329] 'read index received' (duration: 154.239287ms)","trace[827801329] 'applied index is now lower than readState.Index' (duration: 396.457µs)"],"step_count":2} {"level":"info","ts":"2026-05-21T15:29:48.451474Z","caller":"traceutil/trace.go:171","msg":"trace[262502963] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"281.384926ms","start":"2026-05-21T15:29:48.170059Z","end":"2026-05-21T15:29:48.451443Z","steps":["trace[262502963] 'process raft request' (duration: 281.102301ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:29:48.451668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.003074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T15:29:48.45173Z","caller":"traceutil/trace.go:171","msg":"trace[30177554] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1241; }","duration":"137.26476ms","start":"2026-05-21T15:29:48.314448Z","end":"2026-05-21T15:29:48.451713Z","steps":["trace[30177554] 'agreement among raft nodes before linearized reading' (duration: 137.155238ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:29:48.451889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.94584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-21T15:29:48.451998Z","caller":"traceutil/trace.go:171","msg":"trace[825248476] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1241; }","duration":"124.116704ms","start":"2026-05-21T15:29:48.327857Z","end":"2026-05-21T15:29:48.451974Z","steps":["trace[825248476] 'agreement among raft nodes before linearized reading' (duration: 123.796348ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:29:48.451986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.090153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-21T15:29:48.452093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.345137ms","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-05-21T15:29:48.452082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.229455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-21T15:29:48.452109Z","caller":"traceutil/trace.go:171","msg":"trace[721019881] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1241; }","duration":"124.250556ms","start":"2026-05-21T15:29:48.327831Z","end":"2026-05-21T15:29:48.452082Z","steps":["trace[721019881] 'agreement among raft nodes before linearized reading' (duration: 123.908629ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T15:29:48.452181Z","caller":"traceutil/trace.go:171","msg":"trace[472507591] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1241; }","duration":"155.47068ms","start":"2026-05-21T15:29:48.296669Z","end":"2026-05-21T15:29:48.45214Z","steps":["trace[472507591] 'agreement among raft nodes before linearized reading' (duration: 154.93086ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T15:29:48.452179Z","caller":"traceutil/trace.go:171","msg":"trace[1000927021] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1241; }","duration":"124.379128ms","start":"2026-05-21T15:29:48.327778Z","end":"2026-05-21T15:29:48.452157Z","steps":["trace[1000927021] 'agreement among raft nodes before linearized reading' (duration: 124.004121ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:29:48.893773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.52933ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-21T15:29:48.894003Z","caller":"traceutil/trace.go:171","msg":"trace[1715490902] linearizableReadLoop","detail":"{readStateIndex:1286; appliedIndex:1283; }","duration":"171.663343ms","start":"2026-05-21T15:29:48.722322Z","end":"2026-05-21T15:29:48.893986Z","steps":["trace[1715490902] 'read index received' (duration: 62.281µs)","trace[1715490902] 'applied index is now lower than readState.Index' (duration: 171.599922ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T15:29:48.894182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.869576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.240\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-21T15:29:48.894212Z","caller":"traceutil/trace.go:171","msg":"trace[2037495517] range","detail":"{range_begin:/registry/masterleases/199.19.213.240; range_end:; response_count:1; response_revision:1245; }","duration":"171.941938ms","start":"2026-05-21T15:29:48.722259Z","end":"2026-05-21T15:29:48.894201Z","steps":["trace[2037495517] 'agreement among raft nodes before linearized reading' (duration: 171.786905ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T15:29:48.894459Z","caller":"traceutil/trace.go:171","msg":"trace[17991437] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"436.347217ms","start":"2026-05-21T15:29:48.458097Z","end":"2026-05-21T15:29:48.894444Z","steps":["trace[17991437] 'process raft request' (duration: 435.784527ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:29:48.894534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:29:48.458057Z","time spent":"436.437319ms","remote":"127.0.0.1:57560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T15:29:48.894626Z","caller":"traceutil/trace.go:171","msg":"trace[1771311940] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"436.189103ms","start":"2026-05-21T15:29:48.458428Z","end":"2026-05-21T15:29:48.894617Z","steps":["trace[1771311940] 'process raft request' (duration: 435.515351ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:29:48.894683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:29:48.458418Z","time spent":"436.236264ms","remote":"127.0.0.1:57560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T15:29:48.894286Z","caller":"traceutil/trace.go:171","msg":"trace[980208860] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"436.282546ms","start":"2026-05-21T15:29:48.457969Z","end":"2026-05-21T15:29:48.894251Z","steps":["trace[980208860] 'process raft request' (duration: 69.188765ms)","trace[980208860] 'compare' (duration: 365.862048ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T15:29:48.895459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:29:48.457943Z","time spent":"437.373877ms","remote":"127.0.0.1:57560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T15:30:38.492634Z","caller":"traceutil/trace.go:171","msg":"trace[646116312] transaction","detail":"{read_only:false; response_revision:1912; number_of_response:1; }","duration":"161.687736ms","start":"2026-05-21T15:30:38.330924Z","end":"2026-05-21T15:30:38.492611Z","steps":["trace[646116312] 'process raft request' (duration: 72.954207ms)","trace[646116312] 'compare' (duration: 88.547186ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T15:30:38.737279Z","caller":"traceutil/trace.go:171","msg":"trace[1668684353] linearizableReadLoop","detail":"{readStateIndex:1990; appliedIndex:1989; }","duration":"244.66209ms","start":"2026-05-21T15:30:38.492569Z","end":"2026-05-21T15:30:38.737231Z","steps":["trace[1668684353] 'read index received' (duration: 188.925653ms)","trace[1668684353] 'applied index is now lower than readState.Index' (duration: 55.734057ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T15:30:38.73754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.624085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T15:30:38.737601Z","caller":"traceutil/trace.go:171","msg":"trace[2065920625] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1913; }","duration":"247.749828ms","start":"2026-05-21T15:30:38.48984Z","end":"2026-05-21T15:30:38.73759Z","steps":["trace[2065920625] 'agreement among raft nodes before linearized reading' (duration: 247.598905ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T15:30:38.738175Z","caller":"traceutil/trace.go:171","msg":"trace[1356063164] transaction","detail":"{read_only:false; response_revision:1913; number_of_response:1; }","duration":"260.581595ms","start":"2026-05-21T15:30:38.476853Z","end":"2026-05-21T15:30:38.737435Z","steps":["trace[1356063164] 'process raft request' (duration: 204.559673ms)","trace[1356063164] 'compare' (duration: 55.526022ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T15:30:38.740459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.912295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10668"} {"level":"info","ts":"2026-05-21T15:30:38.740482Z","caller":"traceutil/trace.go:171","msg":"trace[699307326] transaction","detail":"{read_only:false; response_revision:1914; number_of_response:1; }","duration":"230.685719ms","start":"2026-05-21T15:30:38.509749Z","end":"2026-05-21T15:30:38.740434Z","steps":["trace[699307326] 'process raft request' (duration: 230.365684ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T15:30:38.740531Z","caller":"traceutil/trace.go:171","msg":"trace[172718630] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1915; }","duration":"244.029847ms","start":"2026-05-21T15:30:38.496482Z","end":"2026-05-21T15:30:38.740512Z","steps":["trace[172718630] 'agreement among raft nodes before linearized reading' (duration: 243.829063ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T15:30:38.890691Z","caller":"traceutil/trace.go:171","msg":"trace[745827660] linearizableReadLoop","detail":"{readStateIndex:1994; appliedIndex:1992; }","duration":"123.444516ms","start":"2026-05-21T15:30:38.767223Z","end":"2026-05-21T15:30:38.890667Z","steps":["trace[745827660] 'read index received' (duration: 13.593303ms)","trace[745827660] 'applied index is now lower than readState.Index' (duration: 109.850023ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T15:30:38.890817Z","caller":"traceutil/trace.go:171","msg":"trace[853336735] transaction","detail":"{read_only:false; response_revision:1916; number_of_response:1; }","duration":"140.35438ms","start":"2026-05-21T15:30:38.750449Z","end":"2026-05-21T15:30:38.890804Z","steps":["trace[853336735] 'process raft request' (duration: 114.883876ms)","trace[853336735] 'compare' (duration: 25.118668ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T15:30:38.891188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.439035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-21T15:30:38.891233Z","caller":"traceutil/trace.go:171","msg":"trace[293329071] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1917; }","duration":"102.568338ms","start":"2026-05-21T15:30:38.788654Z","end":"2026-05-21T15:30:38.891222Z","steps":["trace[293329071] 'agreement among raft nodes before linearized reading' (duration: 102.334522ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:30:38.891499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.276542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-21T15:30:38.891528Z","caller":"traceutil/trace.go:171","msg":"trace[388378429] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1917; }","duration":"124.362193ms","start":"2026-05-21T15:30:38.767156Z","end":"2026-05-21T15:30:38.891519Z","steps":["trace[388378429] 'agreement among raft nodes before linearized reading' (duration: 123.791772ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T15:30:38.891864Z","caller":"traceutil/trace.go:171","msg":"trace[1749076400] transaction","detail":"{read_only:false; response_revision:1917; number_of_response:1; }","duration":"109.534917ms","start":"2026-05-21T15:30:38.782302Z","end":"2026-05-21T15:30:38.891837Z","steps":["trace[1749076400] 'process raft request' (duration: 108.307413ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:30:39.15817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.179009ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-21T15:30:39.158429Z","caller":"traceutil/trace.go:171","msg":"trace[126502510] transaction","detail":"{read_only:false; response_revision:1919; number_of_response:1; }","duration":"260.369641ms","start":"2026-05-21T15:30:38.898019Z","end":"2026-05-21T15:30:39.158388Z","steps":["trace[126502510] 'process raft request' (duration: 120.836907ms)","trace[126502510] 'compare' (duration: 139.035785ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T15:30:39.158604Z","caller":"traceutil/trace.go:171","msg":"trace[746897899] linearizableReadLoop","detail":"{readStateIndex:2001; appliedIndex:1995; }","duration":"259.044127ms","start":"2026-05-21T15:30:38.899535Z","end":"2026-05-21T15:30:39.158579Z","steps":["trace[746897899] 'read index received' (duration: 7.044391ms)","trace[746897899] 'applied index is now lower than readState.Index' (duration: 251.998726ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T15:30:39.158774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.22773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-05-21T15:30:39.158826Z","caller":"traceutil/trace.go:171","msg":"trace[64695058] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:1923; }","duration":"259.293032ms","start":"2026-05-21T15:30:38.899518Z","end":"2026-05-21T15:30:39.158811Z","steps":["trace[64695058] 'agreement among raft nodes before linearized reading' (duration: 259.147179ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T15:30:39.158968Z","caller":"traceutil/trace.go:171","msg":"trace[330055562] transaction","detail":"{read_only:false; response_revision:1921; number_of_response:1; }","duration":"260.28975ms","start":"2026-05-21T15:30:38.898569Z","end":"2026-05-21T15:30:39.158859Z","steps":["trace[330055562] 'process raft request' (duration: 259.814081ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T15:30:39.15899Z","caller":"traceutil/trace.go:171","msg":"trace[353510457] transaction","detail":"{read_only:false; response_revision:1920; number_of_response:1; }","duration":"260.516074ms","start":"2026-05-21T15:30:38.898451Z","end":"2026-05-21T15:30:39.158967Z","steps":["trace[353510457] 'process raft request' (duration: 259.850042ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T15:30:39.159004Z","caller":"traceutil/trace.go:171","msg":"trace[2108945451] transaction","detail":"{read_only:false; response_revision:1922; number_of_response:1; }","duration":"260.31077ms","start":"2026-05-21T15:30:38.898679Z","end":"2026-05-21T15:30:39.15899Z","steps":["trace[2108945451] 'process raft request' (duration: 259.75502ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T15:30:39.159085Z","caller":"traceutil/trace.go:171","msg":"trace[1040922691] transaction","detail":"{read_only:false; response_revision:1923; number_of_response:1; }","duration":"259.632888ms","start":"2026-05-21T15:30:38.899403Z","end":"2026-05-21T15:30:39.159036Z","steps":["trace[1040922691] 'process raft request' (duration: 259.100619ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T15:31:13.278836Z","caller":"traceutil/trace.go:171","msg":"trace[1956950565] transaction","detail":"{read_only:false; response_revision:2156; number_of_response:1; }","duration":"152.780708ms","start":"2026-05-21T15:31:13.126025Z","end":"2026-05-21T15:31:13.278806Z","steps":["trace[1956950565] 'process raft request' (duration: 152.617945ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:31:13.513547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.562377ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-21T15:31:13.513702Z","caller":"traceutil/trace.go:171","msg":"trace[944906857] linearizableReadLoop","detail":"{readStateIndex:2242; appliedIndex:2241; }","duration":"159.287878ms","start":"2026-05-21T15:31:13.354379Z","end":"2026-05-21T15:31:13.513667Z","steps":["trace[944906857] 'read index received' (duration: 50.533548ms)","trace[944906857] 'applied index is now lower than readState.Index' (duration: 108.75287ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T15:31:13.513824Z","caller":"traceutil/trace.go:171","msg":"trace[954734309] transaction","detail":"{read_only:false; response_revision:2157; number_of_response:1; }","duration":"176.144482ms","start":"2026-05-21T15:31:13.337666Z","end":"2026-05-21T15:31:13.51381Z","steps":["trace[954734309] 'process raft request' (duration: 67.219608ms)","trace[954734309] 'compare' (duration: 108.409785ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T15:31:13.514143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.760457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-21T15:31:13.51418Z","caller":"traceutil/trace.go:171","msg":"trace[2100509269] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2157; }","duration":"159.827838ms","start":"2026-05-21T15:31:13.35434Z","end":"2026-05-21T15:31:13.514168Z","steps":["trace[2100509269] 'agreement among raft nodes before linearized reading' (duration: 159.683966ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:31:13.514261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.134245ms","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-05-21T15:31:13.514421Z","caller":"traceutil/trace.go:171","msg":"trace[1135503542] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2157; }","duration":"153.287127ms","start":"2026-05-21T15:31:13.361085Z","end":"2026-05-21T15:31:13.514372Z","steps":["trace[1135503542] 'agreement among raft nodes before linearized reading' (duration: 152.975941ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:31:13.51441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.210636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-21T15:31:13.514569Z","caller":"traceutil/trace.go:171","msg":"trace[1280277354] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2157; }","duration":"153.412449ms","start":"2026-05-21T15:31:13.361141Z","end":"2026-05-21T15:31:13.514553Z","steps":["trace[1280277354] 'agreement among raft nodes before linearized reading' (duration: 153.044063ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:31:14.316808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.293651ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-21T15:31:14.316975Z","caller":"traceutil/trace.go:171","msg":"trace[1913327882] linearizableReadLoop","detail":"{readStateIndex:2247; appliedIndex:2246; }","duration":"182.775554ms","start":"2026-05-21T15:31:14.134169Z","end":"2026-05-21T15:31:14.316945Z","steps":["trace[1913327882] 'read index received' (duration: 77.961µs)","trace[1913327882] 'applied index is now lower than readState.Index' (duration: 182.693523ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T15:31:14.317256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.072851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-21T15:31:14.317405Z","caller":"traceutil/trace.go:171","msg":"trace[91019644] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2161; }","duration":"183.289015ms","start":"2026-05-21T15:31:14.134104Z","end":"2026-05-21T15:31:14.317393Z","steps":["trace[91019644] 'agreement among raft nodes before linearized reading' (duration: 182.965538ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:32:54.308422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.339916ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"warn","ts":"2026-05-21T15:32:54.308919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.331607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-21T15:32:54.30903Z","caller":"traceutil/trace.go:171","msg":"trace[502178414] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2803; }","duration":"134.482896ms","start":"2026-05-21T15:32:54.17451Z","end":"2026-05-21T15:32:54.308993Z","steps":["trace[502178414] 'agreement among raft nodes before linearized reading' (duration: 134.232867ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T15:32:54.308713Z","caller":"traceutil/trace.go:171","msg":"trace[1514053378] linearizableReadLoop","detail":"{readStateIndex:2912; appliedIndex:2911; }","duration":"134.088048ms","start":"2026-05-21T15:32:54.174569Z","end":"2026-05-21T15:32:54.308657Z","steps":["trace[1514053378] 'read index received' (duration: 82.06µs)","trace[1514053378] 'applied index is now lower than readState.Index' (duration: 134.003578ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T15:32:54.3097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.084877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-21T15:32:54.30979Z","caller":"traceutil/trace.go:171","msg":"trace[1834153911] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2803; }","duration":"130.188427ms","start":"2026-05-21T15:32:54.179589Z","end":"2026-05-21T15:32:54.309777Z","steps":["trace[1834153911] 'agreement among raft nodes before linearized reading' (duration: 130.021057ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:32:54.309717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.031763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-21T15:32:54.309986Z","caller":"traceutil/trace.go:171","msg":"trace[1746894035] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2803; }","duration":"135.315682ms","start":"2026-05-21T15:32:54.174631Z","end":"2026-05-21T15:32:54.309947Z","steps":["trace[1746894035] 'agreement among raft nodes before linearized reading' (duration: 134.883344ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:32:54.310122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.154456ms","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-05-21T15:32:54.310247Z","caller":"traceutil/trace.go:171","msg":"trace[1652732585] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2803; }","duration":"132.380475ms","start":"2026-05-21T15:32:54.177841Z","end":"2026-05-21T15:32:54.310222Z","steps":["trace[1652732585] 'agreement among raft nodes before linearized reading' (duration: 131.794738ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T15:32:59.483731Z","caller":"traceutil/trace.go:171","msg":"trace[468099704] transaction","detail":"{read_only:false; response_revision:2831; number_of_response:1; }","duration":"147.250011ms","start":"2026-05-21T15:32:59.336458Z","end":"2026-05-21T15:32:59.483708Z","steps":["trace[468099704] 'process raft request' (duration: 147.092472ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T15:32:59.48445Z","caller":"traceutil/trace.go:171","msg":"trace[947731464] linearizableReadLoop","detail":"{readStateIndex:2942; appliedIndex:2940; }","duration":"135.289517ms","start":"2026-05-21T15:32:59.349034Z","end":"2026-05-21T15:32:59.484323Z","steps":["trace[947731464] 'read index received' (duration: 134.49897ms)","trace[947731464] 'applied index is now lower than readState.Index' (duration: 789.227µs)"],"step_count":2} {"level":"info","ts":"2026-05-21T15:32:59.484527Z","caller":"traceutil/trace.go:171","msg":"trace[792980298] transaction","detail":"{read_only:false; response_revision:2832; number_of_response:1; }","duration":"142.884988ms","start":"2026-05-21T15:32:59.34161Z","end":"2026-05-21T15:32:59.484495Z","steps":["trace[792980298] 'process raft request' (duration: 142.586309ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:32:59.484759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.702175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-21T15:32:59.484831Z","caller":"traceutil/trace.go:171","msg":"trace[1746278385] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:2832; }","duration":"135.789265ms","start":"2026-05-21T15:32:59.349028Z","end":"2026-05-21T15:32:59.484818Z","steps":["trace[1746278385] 'agreement among raft nodes before linearized reading' (duration: 135.676685ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:36:51.190643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.375677ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T15:36:51.190813Z","caller":"traceutil/trace.go:171","msg":"trace[1331173842] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:4818; }","duration":"141.580229ms","start":"2026-05-21T15:36:51.049206Z","end":"2026-05-21T15:36:51.190787Z","steps":["trace[1331173842] 'range keys from in-memory index tree' (duration: 141.351677ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T15:36:51.193136Z","caller":"traceutil/trace.go:171","msg":"trace[1856297226] linearizableReadLoop","detail":"{readStateIndex:5008; appliedIndex:5007; }","duration":"104.278163ms","start":"2026-05-21T15:36:51.088787Z","end":"2026-05-21T15:36:51.193065Z","steps":["trace[1856297226] 'read index received' (duration: 103.946589ms)","trace[1856297226] 'applied index is now lower than readState.Index' (duration: 330.564µs)"],"step_count":2} {"level":"info","ts":"2026-05-21T15:36:51.193675Z","caller":"traceutil/trace.go:171","msg":"trace[1951793445] transaction","detail":"{read_only:false; response_revision:4819; number_of_response:1; }","duration":"190.143347ms","start":"2026-05-21T15:36:51.003509Z","end":"2026-05-21T15:36:51.193652Z","steps":["trace[1951793445] 'process raft request' (duration: 189.333587ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:36:51.194936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.135496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2206973"} {"level":"info","ts":"2026-05-21T15:36:51.195031Z","caller":"traceutil/trace.go:171","msg":"trace[1076965213] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4819; }","duration":"106.291459ms","start":"2026-05-21T15:36:51.088714Z","end":"2026-05-21T15:36:51.195006Z","steps":["trace[1076965213] 'agreement among raft nodes before linearized reading' (duration: 104.534616ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:36:51.824612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.090756ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-21T15:36:51.824988Z","caller":"traceutil/trace.go:171","msg":"trace[385377194] transaction","detail":"{read_only:false; response_revision:4821; number_of_response:1; }","duration":"569.346087ms","start":"2026-05-21T15:36:51.255618Z","end":"2026-05-21T15:36:51.824964Z","steps":["trace[385377194] 'process raft request' (duration: 569.144575ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:36:51.825096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:36:51.255588Z","time spent":"569.453149ms","remote":"127.0.0.1:57560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T15:36:51.825149Z","caller":"traceutil/trace.go:171","msg":"trace[360486950] transaction","detail":"{read_only:false; response_revision:4820; number_of_response:1; }","duration":"625.279656ms","start":"2026-05-21T15:36:51.199771Z","end":"2026-05-21T15:36:51.82505Z","steps":["trace[360486950] 'process raft request' (duration: 158.665483ms)","trace[360486950] 'compare' (duration: 465.64285ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T15:36:51.825386Z","caller":"traceutil/trace.go:171","msg":"trace[199348486] linearizableReadLoop","detail":"{readStateIndex:5009; appliedIndex:5008; }","duration":"595.21008ms","start":"2026-05-21T15:36:51.230079Z","end":"2026-05-21T15:36:51.825289Z","steps":["trace[199348486] 'read index received' (duration: 128.338444ms)","trace[199348486] 'applied index is now lower than readState.Index' (duration: 466.865236ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T15:36:51.825789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.999705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-05-21T15:36:51.825842Z","caller":"traceutil/trace.go:171","msg":"trace[938847948] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4821; }","duration":"526.099527ms","start":"2026-05-21T15:36:51.299726Z","end":"2026-05-21T15:36:51.825826Z","steps":["trace[938847948] 'agreement among raft nodes before linearized reading' (duration: 525.942325ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:36:51.825917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:36:51.2997Z","time spent":"526.208608ms","remote":"127.0.0.1:57560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-05-21T15:36:51.825881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.864701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-21T15:36:51.825981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.409313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-91485adb-2a42-4686-a54f-293ff2bdad97\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-05-21T15:36:51.826065Z","caller":"traceutil/trace.go:171","msg":"trace[1087160740] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-91485adb-2a42-4686-a54f-293ff2bdad97; range_end:; response_count:1; response_revision:4821; }","duration":"231.552125ms","start":"2026-05-21T15:36:51.594472Z","end":"2026-05-21T15:36:51.826024Z","steps":["trace[1087160740] 'agreement among raft nodes before linearized reading' (duration: 231.214481ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:36:51.826097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.8106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-21T15:36:51.826131Z","caller":"traceutil/trace.go:171","msg":"trace[17665863] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4821; }","duration":"164.862731ms","start":"2026-05-21T15:36:51.661258Z","end":"2026-05-21T15:36:51.826121Z","steps":["trace[17665863] 'agreement among raft nodes before linearized reading' (duration: 164.76324ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:36:51.826191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.733309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-05-21T15:36:51.826241Z","caller":"traceutil/trace.go:171","msg":"trace[334562549] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4821; }","duration":"444.780709ms","start":"2026-05-21T15:36:51.381446Z","end":"2026-05-21T15:36:51.826227Z","steps":["trace[334562549] 'agreement among raft nodes before linearized reading' (duration: 444.628788ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:36:51.826274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:36:51.381411Z","time spent":"444.854681ms","remote":"127.0.0.1:57426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1957,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"info","ts":"2026-05-21T15:36:51.825991Z","caller":"traceutil/trace.go:171","msg":"trace[831701588] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4821; }","duration":"169.040052ms","start":"2026-05-21T15:36:51.656927Z","end":"2026-05-21T15:36:51.825967Z","steps":["trace[831701588] 'agreement among raft nodes before linearized reading' (duration: 168.768619ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:36:51.826542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.649268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T15:36:51.826586Z","caller":"traceutil/trace.go:171","msg":"trace[1027604498] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4821; }","duration":"512.709159ms","start":"2026-05-21T15:36:51.313865Z","end":"2026-05-21T15:36:51.826575Z","steps":["trace[1027604498] 'agreement among raft nodes before linearized reading' (duration: 512.617518ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:36:51.826605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.221505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12975"} {"level":"info","ts":"2026-05-21T15:36:51.826644Z","caller":"traceutil/trace.go:171","msg":"trace[1664406161] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4821; }","duration":"477.326016ms","start":"2026-05-21T15:36:51.349309Z","end":"2026-05-21T15:36:51.826635Z","steps":["trace[1664406161] 'agreement among raft nodes before linearized reading' (duration: 477.152724ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:36:51.826677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:36:51.349256Z","time spent":"477.415887ms","remote":"127.0.0.1:57464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":1,"response size":12997,"request content":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"warn","ts":"2026-05-21T15:36:51.826704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.446327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-21T15:36:51.826392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.256568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-21T15:36:51.826748Z","caller":"traceutil/trace.go:171","msg":"trace[545759278] range","detail":"{range_begin:/registry/secretgen.k14s.io/rsakeys/; range_end:/registry/secretgen.k14s.io/rsakeys0; response_count:0; response_revision:4821; }","duration":"505.499809ms","start":"2026-05-21T15:36:51.321234Z","end":"2026-05-21T15:36:51.826733Z","steps":["trace[545759278] 'agreement among raft nodes before linearized reading' (duration: 505.432458ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:36:51.826785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:36:51.321226Z","time spent":"505.550229ms","remote":"127.0.0.1:34152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true "} {"level":"info","ts":"2026-05-21T15:36:51.826798Z","caller":"traceutil/trace.go:171","msg":"trace[1152289762] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4821; }","duration":"182.720654ms","start":"2026-05-21T15:36:51.644053Z","end":"2026-05-21T15:36:51.826773Z","steps":["trace[1152289762] 'agreement among raft nodes before linearized reading' (duration: 182.164097ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:36:51.826636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:36:51.313854Z","time spent":"512.771449ms","remote":"127.0.0.1:57284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-21T15:36:51.827787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.478949ms","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-05-21T15:36:51.82786Z","caller":"traceutil/trace.go:171","msg":"trace[1882895414] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4821; }","duration":"181.60741ms","start":"2026-05-21T15:36:51.64624Z","end":"2026-05-21T15:36:51.827848Z","steps":["trace[1882895414] 'agreement among raft nodes before linearized reading' (duration: 179.465953ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:36:51.825581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:36:51.199747Z","time spent":"625.52102ms","remote":"127.0.0.1:57344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":814,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-21T15:36:51.82931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.228071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-05-21T15:36:51.829377Z","caller":"traceutil/trace.go:171","msg":"trace[1037174598] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4821; }","duration":"599.333312ms","start":"2026-05-21T15:36:51.230027Z","end":"2026-05-21T15:36:51.82936Z","steps":["trace[1037174598] 'agreement among raft nodes before linearized reading' (duration: 595.585945ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:36:51.829432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T15:36:51.229988Z","time spent":"599.429013ms","remote":"127.0.0.1:57366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":1839,"request content":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" "} {"level":"warn","ts":"2026-05-21T15:36:52.086426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.476868ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-21T15:36:52.086572Z","caller":"traceutil/trace.go:171","msg":"trace[474263801] linearizableReadLoop","detail":"{readStateIndex:5016; appliedIndex:5015; }","duration":"204.262296ms","start":"2026-05-21T15:36:51.882287Z","end":"2026-05-21T15:36:52.08655Z","steps":["trace[474263801] 'read index received' (duration: 47.431533ms)","trace[474263801] 'applied index is now lower than readState.Index' (duration: 156.829383ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T15:36:52.086959Z","caller":"traceutil/trace.go:171","msg":"trace[637310318] transaction","detail":"{read_only:false; response_revision:4827; number_of_response:1; }","duration":"241.373719ms","start":"2026-05-21T15:36:51.845539Z","end":"2026-05-21T15:36:52.086912Z","steps":["trace[637310318] 'process raft request' (duration: 84.254153ms)","trace[637310318] 'compare' (duration: 156.281376ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T15:36:52.087028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.063148ms","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-05-21T15:36:52.08709Z","caller":"traceutil/trace.go:171","msg":"trace[1517469930] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4827; }","duration":"230.162909ms","start":"2026-05-21T15:36:51.856909Z","end":"2026-05-21T15:36:52.087072Z","steps":["trace[1517469930] 'agreement among raft nodes before linearized reading' (duration: 229.966797ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:36:52.087714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.562101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-c52ff4a1-1e92-4090-99e7-dd6596d0f0e1\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-05-21T15:36:52.087992Z","caller":"traceutil/trace.go:171","msg":"trace[216774821] range","detail":"{range_begin:/registry/persistentvolumes/pvc-c52ff4a1-1e92-4090-99e7-dd6596d0f0e1; range_end:; response_count:1; response_revision:4827; }","duration":"253.718713ms","start":"2026-05-21T15:36:51.834084Z","end":"2026-05-21T15:36:52.087803Z","steps":["trace[216774821] 'agreement among raft nodes before linearized reading' (duration: 252.524239ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:36:52.088206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.438459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-8f644d9c6-f67j7.18b19eb0e213350a\" ","response":"range_response_count:1 size:895"} {"level":"info","ts":"2026-05-21T15:36:52.088526Z","caller":"traceutil/trace.go:171","msg":"trace[1109712966] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-8f644d9c6-f67j7.18b19eb0e213350a; range_end:; response_count:1; response_revision:4827; }","duration":"253.029016ms","start":"2026-05-21T15:36:51.835473Z","end":"2026-05-21T15:36:52.088502Z","steps":["trace[1109712966] 'agreement among raft nodes before linearized reading' (duration: 251.534406ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T15:36:52.279031Z","caller":"traceutil/trace.go:171","msg":"trace[1821275029] transaction","detail":"{read_only:false; response_revision:4828; number_of_response:1; }","duration":"184.317788ms","start":"2026-05-21T15:36:52.094688Z","end":"2026-05-21T15:36:52.279006Z","steps":["trace[1821275029] 'process raft request' (duration: 123.174672ms)","trace[1821275029] 'compare' (duration: 60.819232ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T15:36:52.279429Z","caller":"traceutil/trace.go:171","msg":"trace[536325562] transaction","detail":"{read_only:false; response_revision:4829; number_of_response:1; }","duration":"180.255937ms","start":"2026-05-21T15:36:52.099164Z","end":"2026-05-21T15:36:52.27942Z","steps":["trace[536325562] 'process raft request' (duration: 179.705881ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T15:36:52.2797Z","caller":"traceutil/trace.go:171","msg":"trace[119458973] linearizableReadLoop","detail":"{readStateIndex:5020; appliedIndex:5016; }","duration":"180.299038ms","start":"2026-05-21T15:36:52.099392Z","end":"2026-05-21T15:36:52.279691Z","steps":["trace[119458973] 'read index received' (duration: 118.486554ms)","trace[119458973] 'applied index is now lower than readState.Index' (duration: 61.810764ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T15:36:52.279867Z","caller":"traceutil/trace.go:171","msg":"trace[911108625] transaction","detail":"{read_only:false; response_revision:4830; number_of_response:1; }","duration":"180.556491ms","start":"2026-05-21T15:36:52.099296Z","end":"2026-05-21T15:36:52.279852Z","steps":["trace[911108625] 'process raft request' (duration: 180.038444ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T15:36:52.279913Z","caller":"traceutil/trace.go:171","msg":"trace[1894217611] transaction","detail":"{read_only:false; response_revision:4831; number_of_response:1; }","duration":"180.570601ms","start":"2026-05-21T15:36:52.099333Z","end":"2026-05-21T15:36:52.279904Z","steps":["trace[1894217611] 'process raft request' (duration: 180.287928ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:36:52.280197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.788354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-05-21T15:36:52.280235Z","caller":"traceutil/trace.go:171","msg":"trace[1672512882] 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:4832; }","duration":"180.886845ms","start":"2026-05-21T15:36:52.099336Z","end":"2026-05-21T15:36:52.280223Z","steps":["trace[1672512882] 'agreement among raft nodes before linearized reading' (duration: 180.752564ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T15:36:52.28036Z","caller":"traceutil/trace.go:171","msg":"trace[484306771] transaction","detail":"{read_only:false; response_revision:4832; number_of_response:1; }","duration":"178.463496ms","start":"2026-05-21T15:36:52.10188Z","end":"2026-05-21T15:36:52.280343Z","steps":["trace[484306771] 'process raft request' (duration: 177.780827ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:36:52.28104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.543183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16232"} {"level":"info","ts":"2026-05-21T15:36:52.281976Z","caller":"traceutil/trace.go:171","msg":"trace[533610990] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4832; }","duration":"182.473695ms","start":"2026-05-21T15:36:52.099484Z","end":"2026-05-21T15:36:52.281958Z","steps":["trace[533610990] 'agreement among raft nodes before linearized reading' (duration: 181.456132ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:36:52.281364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.671475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-05-21T15:36:52.282174Z","caller":"traceutil/trace.go:171","msg":"trace[1080646810] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4832; }","duration":"182.551337ms","start":"2026-05-21T15:36:52.099597Z","end":"2026-05-21T15:36:52.282148Z","steps":["trace[1080646810] 'agreement among raft nodes before linearized reading' (duration: 181.508823ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T15:37:04.122225Z","caller":"traceutil/trace.go:171","msg":"trace[2126523841] linearizableReadLoop","detail":"{readStateIndex:5187; appliedIndex:5186; }","duration":"157.880311ms","start":"2026-05-21T15:37:03.964314Z","end":"2026-05-21T15:37:04.122194Z","steps":["trace[2126523841] 'read index received' (duration: 124.670276ms)","trace[2126523841] 'applied index is now lower than readState.Index' (duration: 33.208955ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T15:37:04.122244Z","caller":"traceutil/trace.go:171","msg":"trace[1941928854] transaction","detail":"{read_only:false; response_revision:4993; number_of_response:1; }","duration":"205.699752ms","start":"2026-05-21T15:37:03.916508Z","end":"2026-05-21T15:37:04.122208Z","steps":["trace[1941928854] 'process raft request' (duration: 172.416056ms)","trace[1941928854] 'compare' (duration: 32.533026ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T15:37:04.122507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.155164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-21T15:37:04.12258Z","caller":"traceutil/trace.go:171","msg":"trace[259983519] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4993; }","duration":"158.305347ms","start":"2026-05-21T15:37:03.964258Z","end":"2026-05-21T15:37:04.122564Z","steps":["trace[259983519] 'agreement among raft nodes before linearized reading' (duration: 158.042763ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:37:04.122687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.069322ms","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-05-21T15:37:04.122857Z","caller":"traceutil/trace.go:171","msg":"trace[816353998] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4993; }","duration":"157.318055ms","start":"2026-05-21T15:37:03.965519Z","end":"2026-05-21T15:37:04.122837Z","steps":["trace[816353998] 'agreement among raft nodes before linearized reading' (duration: 156.870108ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:37:04.123126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.567738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-05-21T15:37:04.123184Z","caller":"traceutil/trace.go:171","msg":"trace[1396701881] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4993; }","duration":"157.70089ms","start":"2026-05-21T15:37:03.965471Z","end":"2026-05-21T15:37:04.123172Z","steps":["trace[1396701881] 'agreement among raft nodes before linearized reading' (duration: 156.926059ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:37:04.1233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.917242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-21T15:37:04.123358Z","caller":"traceutil/trace.go:171","msg":"trace[192648824] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4993; }","duration":"158.588461ms","start":"2026-05-21T15:37:03.964755Z","end":"2026-05-21T15:37:04.123344Z","steps":["trace[192648824] 'agreement among raft nodes before linearized reading' (duration: 157.624098ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T15:37:04.375198Z","caller":"traceutil/trace.go:171","msg":"trace[2112921] transaction","detail":"{read_only:false; response_revision:4994; number_of_response:1; }","duration":"247.45889ms","start":"2026-05-21T15:37:04.127705Z","end":"2026-05-21T15:37:04.375163Z","steps":["trace[2112921] 'process raft request' (duration: 197.104115ms)","trace[2112921] 'compare' (duration: 49.94756ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T15:37:04.394199Z","caller":"traceutil/trace.go:171","msg":"trace[478573743] transaction","detail":"{read_only:false; response_revision:4996; number_of_response:1; }","duration":"265.992726ms","start":"2026-05-21T15:37:04.128164Z","end":"2026-05-21T15:37:04.394157Z","steps":["trace[478573743] 'process raft request' (duration: 265.793003ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T15:37:04.394258Z","caller":"traceutil/trace.go:171","msg":"trace[1463341211] transaction","detail":"{read_only:false; response_revision:4997; number_of_response:1; }","duration":"265.763022ms","start":"2026-05-21T15:37:04.128455Z","end":"2026-05-21T15:37:04.394218Z","steps":["trace[1463341211] 'process raft request' (duration: 265.54607ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T15:37:04.394272Z","caller":"traceutil/trace.go:171","msg":"trace[1154274424] transaction","detail":"{read_only:false; response_revision:4995; number_of_response:1; }","duration":"266.320211ms","start":"2026-05-21T15:37:04.127929Z","end":"2026-05-21T15:37:04.394249Z","steps":["trace[1154274424] 'process raft request' (duration: 265.853465ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T15:37:04.458948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.704854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T15:37:04.459083Z","caller":"traceutil/trace.go:171","msg":"trace[1590374514] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:4998; }","duration":"126.852585ms","start":"2026-05-21T15:37:04.332182Z","end":"2026-05-21T15:37:04.459035Z","steps":["trace[1590374514] 'agreement among raft nodes before linearized reading' (duration: 126.332648ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T15:38:05.684084Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2866} {"level":"info","ts":"2026-05-21T15:38:05.839209Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2866,"took":"153.834117ms","hash":289615667,"current-db-size-bytes":53415936,"current-db-size":"53 MB","current-db-size-in-use-bytes":28979200,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-21T15:38:05.839367Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":289615667,"revision":2866,"compact-revision":-1} {"level":"warn","ts":"2026-05-21T15:41:07.256405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.087766ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-21T15:41:07.256531Z","caller":"traceutil/trace.go:171","msg":"trace[756731666] transaction","detail":"{read_only:false; response_revision:6767; number_of_response:1; }","duration":"296.075001ms","start":"2026-05-21T15:41:06.960428Z","end":"2026-05-21T15:41:07.256503Z","steps":["trace[756731666] 'process raft request' (duration: 153.794673ms)","trace[756731666] 'compare' (duration: 141.810551ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T15:43:05.692852Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5514} {"level":"info","ts":"2026-05-21T15:43:05.792463Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5514,"took":"97.839378ms","hash":2127461429,"current-db-size-bytes":53415936,"current-db-size":"53 MB","current-db-size-in-use-bytes":18518016,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-21T15:43:05.792535Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2127461429,"revision":5514,"compact-revision":2866}