{"level":"warn","ts":"2026-06-10T15:13:34.349148Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-10T15:13:34.349239Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.57:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.57:2380","--initial-cluster=instance=https://199.204.45.57:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.57:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.57: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-06-10T15:13:34.349302Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-10T15:13:34.349312Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.57:2380"]} {"level":"info","ts":"2026-06-10T15:13:34.349329Z","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-06-10T15:13:34.350003Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"]} {"level":"info","ts":"2026-06-10T15:13:34.350084Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.57: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-06-10T15:13:34.353628Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.331482ms"} {"level":"info","ts":"2026-06-10T15:13:34.358855Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b6478f0ac5aeb8e1","cluster-id":"6c58cff80d4a5b62"} {"level":"info","ts":"2026-06-10T15:13:34.358934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=()"} {"level":"info","ts":"2026-06-10T15:13:34.35896Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 0"} {"level":"info","ts":"2026-06-10T15:13:34.358971Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b6478f0ac5aeb8e1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-10T15:13:34.358984Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 1"} {"level":"info","ts":"2026-06-10T15:13:34.359023Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"} {"level":"warn","ts":"2026-06-10T15:13:34.364737Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-10T15:13:34.366207Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-10T15:13:34.367327Z","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-06-10T15:13:34.369504Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b6478f0ac5aeb8e1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-10T15:13:34.369667Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b6478f0ac5aeb8e1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-10T15:13:34.369856Z","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-06-10T15:13:34.37002Z","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-06-10T15:13:34.37008Z","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-06-10T15:13:34.372119Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"} {"level":"info","ts":"2026-06-10T15:13:34.372653Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","added-peer-id":"b6478f0ac5aeb8e1","added-peer-peer-urls":["https://199.204.45.57:2380"]} {"level":"info","ts":"2026-06-10T15:13:34.374128Z","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-06-10T15:13:34.374266Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.57:2380"} {"level":"info","ts":"2026-06-10T15:13:34.374369Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.57:2380"} {"level":"info","ts":"2026-06-10T15:13:34.374561Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b6478f0ac5aeb8e1","initial-advertise-peer-urls":["https://199.204.45.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-10T15:13:34.374594Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-10T15:13:34.459563Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 is starting a new election at term 1"} {"level":"info","ts":"2026-06-10T15:13:34.459677Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-10T15:13:34.459775Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgPreVoteResp from b6478f0ac5aeb8e1 at term 1"} {"level":"info","ts":"2026-06-10T15:13:34.459835Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became candidate at term 2"} {"level":"info","ts":"2026-06-10T15:13:34.459862Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgVoteResp from b6478f0ac5aeb8e1 at term 2"} {"level":"info","ts":"2026-06-10T15:13:34.459934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became leader at term 2"} {"level":"info","ts":"2026-06-10T15:13:34.459986Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b6478f0ac5aeb8e1 elected leader b6478f0ac5aeb8e1 at term 2"} {"level":"info","ts":"2026-06-10T15:13:34.461512Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b6478f0ac5aeb8e1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.57:2379]}","request-path":"/0/members/b6478f0ac5aeb8e1/attributes","cluster-id":"6c58cff80d4a5b62","publish-timeout":"7s"} {"level":"info","ts":"2026-06-10T15:13:34.461616Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-10T15:13:34.461671Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-10T15:13:34.461718Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T15:13:34.462339Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-10T15:13:34.462384Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-10T15:13:34.462544Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T15:13:34.462636Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T15:13:34.462663Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T15:13:34.464363Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.57:2379"} {"level":"info","ts":"2026-06-10T15:13:34.465155Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-10T15:13:49.777349Z","caller":"traceutil/trace.go:171","msg":"trace[1745969019] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"179.219061ms","start":"2026-06-10T15:13:49.598086Z","end":"2026-06-10T15:13:49.777306Z","steps":["trace[1745969019] 'process raft request' (duration: 178.958595ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:13:49.851156Z","caller":"traceutil/trace.go:171","msg":"trace[556146365] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"138.315623ms","start":"2026-06-10T15:13:49.712811Z","end":"2026-06-10T15:13:49.851126Z","steps":["trace[556146365] 'process raft request' (duration: 138.160409ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:14:11.054351Z","caller":"traceutil/trace.go:171","msg":"trace[1931712384] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"132.793395ms","start":"2026-06-10T15:14:10.921483Z","end":"2026-06-10T15:14:11.054276Z","steps":["trace[1931712384] 'process raft request' (duration: 96.1718ms)","trace[1931712384] 'compare' (duration: 36.205575ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T15:14:11.31679Z","caller":"traceutil/trace.go:171","msg":"trace[1838010081] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"180.07368ms","start":"2026-06-10T15:14:11.136652Z","end":"2026-06-10T15:14:11.316726Z","steps":["trace[1838010081] 'process raft request' (duration: 94.047237ms)","trace[1838010081] 'compare' (duration: 85.722166ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T15:14:11.316883Z","caller":"traceutil/trace.go:171","msg":"trace[627941839] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"180.088521ms","start":"2026-06-10T15:14:11.136749Z","end":"2026-06-10T15:14:11.316838Z","steps":["trace[627941839] 'process raft request' (duration: 179.898276ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:14:11.316869Z","caller":"traceutil/trace.go:171","msg":"trace[109662472] linearizableReadLoop","detail":"{readStateIndex:515; appliedIndex:513; }","duration":"151.088947ms","start":"2026-06-10T15:14:11.165737Z","end":"2026-06-10T15:14:11.316826Z","steps":["trace[109662472] 'read index received' (duration: 64.977171ms)","trace[109662472] 'applied index is now lower than readState.Index' (duration: 86.109326ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T15:14:11.317085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.326483ms","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-06-10T15:14:11.317206Z","caller":"traceutil/trace.go:171","msg":"trace[1737998601] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:498; }","duration":"151.514968ms","start":"2026-06-10T15:14:11.165678Z","end":"2026-06-10T15:14:11.317193Z","steps":["trace[1737998601] 'agreement among raft nodes before linearized reading' (duration: 151.271792ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:14:13.444376Z","caller":"traceutil/trace.go:171","msg":"trace[293192163] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"128.874087ms","start":"2026-06-10T15:14:13.315473Z","end":"2026-06-10T15:14:13.444347Z","steps":["trace[293192163] 'process raft request' (duration: 79.939641ms)","trace[293192163] 'compare' (duration: 48.68936ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T15:14:13.444607Z","caller":"traceutil/trace.go:171","msg":"trace[407302914] linearizableReadLoop","detail":"{readStateIndex:585; appliedIndex:583; }","duration":"123.943251ms","start":"2026-06-10T15:14:13.320639Z","end":"2026-06-10T15:14:13.444582Z","steps":["trace[407302914] 'read index received' (duration: 7.285975ms)","trace[407302914] 'applied index is now lower than readState.Index' (duration: 116.656056ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T15:14:13.444706Z","caller":"traceutil/trace.go:171","msg":"trace[477271511] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"121.993482ms","start":"2026-06-10T15:14:13.322704Z","end":"2026-06-10T15:14:13.444697Z","steps":["trace[477271511] 'process raft request' (duration: 121.595552ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:14:13.444871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.213668ms","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-06-10T15:14:13.444914Z","caller":"traceutil/trace.go:171","msg":"trace[2046234608] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:564; }","duration":"124.341082ms","start":"2026-06-10T15:14:13.320563Z","end":"2026-06-10T15:14:13.444904Z","steps":["trace[2046234608] 'agreement among raft nodes before linearized reading' (duration: 124.188028ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:14:13.451796Z","caller":"traceutil/trace.go:171","msg":"trace[615034241] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"118.34866ms","start":"2026-06-10T15:14:13.333328Z","end":"2026-06-10T15:14:13.451677Z","steps":["trace[615034241] 'process raft request' (duration: 116.299498ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:14:13.452115Z","caller":"traceutil/trace.go:171","msg":"trace[757556033] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"113.474258ms","start":"2026-06-10T15:14:13.338552Z","end":"2026-06-10T15:14:13.452026Z","steps":["trace[757556033] 'process raft request' (duration: 113.022027ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:14:13.452599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.90172ms","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-06-10T15:14:13.452692Z","caller":"traceutil/trace.go:171","msg":"trace[2146803131] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:566; }","duration":"124.041454ms","start":"2026-06-10T15:14:13.328624Z","end":"2026-06-10T15:14:13.452665Z","steps":["trace[2146803131] 'agreement among raft nodes before linearized reading' (duration: 123.412718ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:14:19.319876Z","caller":"traceutil/trace.go:171","msg":"trace[1261561165] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"131.969176ms","start":"2026-06-10T15:14:19.187868Z","end":"2026-06-10T15:14:19.319838Z","steps":["trace[1261561165] 'process raft request' (duration: 131.725059ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:14:19.921826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.202155ms","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-06-10T15:14:19.921925Z","caller":"traceutil/trace.go:171","msg":"trace[1163755953] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:633; }","duration":"433.349958ms","start":"2026-06-10T15:14:19.488554Z","end":"2026-06-10T15:14:19.921904Z","steps":["trace[1163755953] 'range keys from in-memory index tree' (duration: 433.02829ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:14:19.921972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T15:14:19.488538Z","time spent":"433.426061ms","remote":"127.0.0.1:48978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-10T15:14:19.922084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.556762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-10T15:14:19.922065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.26149ms","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-06-10T15:14:19.922186Z","caller":"traceutil/trace.go:171","msg":"trace[35512356] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:633; }","duration":"423.704206ms","start":"2026-06-10T15:14:19.498459Z","end":"2026-06-10T15:14:19.922163Z","steps":["trace[35512356] 'range keys from in-memory index tree' (duration: 423.376487ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:14:19.922236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T15:14:19.498446Z","time spent":"423.780068ms","remote":"127.0.0.1:48978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-10T15:14:19.922199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.958217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-vdcpr\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-06-10T15:14:19.922318Z","caller":"traceutil/trace.go:171","msg":"trace[1531434181] range","detail":"{range_begin:/registry/pods/kube-system/cilium-vdcpr; range_end:; response_count:1; response_revision:633; }","duration":"461.142821ms","start":"2026-06-10T15:14:19.461142Z","end":"2026-06-10T15:14:19.922285Z","steps":["trace[1531434181] 'range keys from in-memory index tree' (duration: 460.70983ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:14:19.922367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T15:14:19.461113Z","time spent":"461.244344ms","remote":"127.0.0.1:48880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-vdcpr\" "} {"level":"info","ts":"2026-06-10T15:14:19.922238Z","caller":"traceutil/trace.go:171","msg":"trace[540998890] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:633; }","duration":"295.457935ms","start":"2026-06-10T15:14:19.626754Z","end":"2026-06-10T15:14:19.922212Z","steps":["trace[540998890] 'range keys from in-memory index tree' (duration: 295.22929ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:14:19.928008Z","caller":"traceutil/trace.go:171","msg":"trace[873279420] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"146.000159ms","start":"2026-06-10T15:14:19.781975Z","end":"2026-06-10T15:14:19.927976Z","steps":["trace[873279420] 'process raft request' (duration: 145.401773ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:15:02.278514Z","caller":"traceutil/trace.go:171","msg":"trace[1106557038] transaction","detail":"{read_only:false; response_revision:1188; number_of_response:1; }","duration":"115.169043ms","start":"2026-06-10T15:15:02.163312Z","end":"2026-06-10T15:15:02.278481Z","steps":["trace[1106557038] 'process raft request' (duration: 114.956098ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:15:20.809995Z","caller":"traceutil/trace.go:171","msg":"trace[66227079] transaction","detail":"{read_only:false; response_revision:1377; number_of_response:1; }","duration":"100.390252ms","start":"2026-06-10T15:15:20.709572Z","end":"2026-06-10T15:15:20.809962Z","steps":["trace[66227079] 'process raft request' (duration: 61.753941ms)","trace[66227079] 'compare' (duration: 38.430925ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T15:15:20.83002Z","caller":"traceutil/trace.go:171","msg":"trace[1473838238] linearizableReadLoop","detail":"{readStateIndex:1422; appliedIndex:1420; }","duration":"103.427599ms","start":"2026-06-10T15:15:20.726558Z","end":"2026-06-10T15:15:20.829985Z","steps":["trace[1473838238] 'read index received' (duration: 44.696833ms)","trace[1473838238] 'applied index is now lower than readState.Index' (duration: 58.729376ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T15:15:20.830124Z","caller":"traceutil/trace.go:171","msg":"trace[729598762] transaction","detail":"{read_only:false; response_revision:1378; number_of_response:1; }","duration":"119.932083ms","start":"2026-06-10T15:15:20.710133Z","end":"2026-06-10T15:15:20.830065Z","steps":["trace[729598762] 'process raft request' (duration: 119.687927ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:15:20.830249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.650984ms","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-06-10T15:15:20.8303Z","caller":"traceutil/trace.go:171","msg":"trace[972762406] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1378; }","duration":"103.765106ms","start":"2026-06-10T15:15:20.726523Z","end":"2026-06-10T15:15:20.830288Z","steps":["trace[972762406] 'agreement among raft nodes before linearized reading' (duration: 103.622343ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:15:21.087657Z","caller":"traceutil/trace.go:171","msg":"trace[589863618] transaction","detail":"{read_only:false; response_revision:1406; number_of_response:1; }","duration":"102.447644ms","start":"2026-06-10T15:15:20.985175Z","end":"2026-06-10T15:15:21.087623Z","steps":["trace[589863618] 'process raft request' (duration: 67.095885ms)","trace[589863618] 'compare' (duration: 35.205745ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T15:15:21.104456Z","caller":"traceutil/trace.go:171","msg":"trace[2092712918] transaction","detail":"{read_only:false; response_revision:1407; number_of_response:1; }","duration":"105.295576ms","start":"2026-06-10T15:15:20.999129Z","end":"2026-06-10T15:15:21.104425Z","steps":["trace[2092712918] 'process raft request' (duration: 105.090321ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:15:49.147316Z","caller":"traceutil/trace.go:171","msg":"trace[75492255] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"152.522121ms","start":"2026-06-10T15:15:48.994771Z","end":"2026-06-10T15:15:49.147293Z","steps":["trace[75492255] 'process raft request' (duration: 147.124486ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:15:49.191637Z","caller":"traceutil/trace.go:171","msg":"trace[1104256782] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"196.013534ms","start":"2026-06-10T15:15:48.995595Z","end":"2026-06-10T15:15:49.191608Z","steps":["trace[1104256782] 'process raft request' (duration: 195.805119ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:15:49.191852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.290475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T15:15:49.191888Z","caller":"traceutil/trace.go:171","msg":"trace[1640832736] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1867; }","duration":"105.405268ms","start":"2026-06-10T15:15:49.086475Z","end":"2026-06-10T15:15:49.19188Z","steps":["trace[1640832736] 'agreement among raft nodes before linearized reading' (duration: 105.224814ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:15:49.191679Z","caller":"traceutil/trace.go:171","msg":"trace[817262836] linearizableReadLoop","detail":"{readStateIndex:1940; appliedIndex:1934; }","duration":"105.119051ms","start":"2026-06-10T15:15:49.086548Z","end":"2026-06-10T15:15:49.191667Z","steps":["trace[817262836] 'read index received' (duration: 55.374051ms)","trace[817262836] 'applied index is now lower than readState.Index' (duration: 49.74382ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T15:15:49.192106Z","caller":"traceutil/trace.go:171","msg":"trace[1342730145] transaction","detail":"{read_only:false; response_revision:1866; number_of_response:1; }","duration":"176.956266ms","start":"2026-06-10T15:15:49.015141Z","end":"2026-06-10T15:15:49.192098Z","steps":["trace[1342730145] 'process raft request' (duration: 176.472764ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:15:49.192173Z","caller":"traceutil/trace.go:171","msg":"trace[1169104919] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"171.037067ms","start":"2026-06-10T15:15:49.021129Z","end":"2026-06-10T15:15:49.192166Z","steps":["trace[1169104919] 'process raft request' (duration: 170.514484ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:15:49.192312Z","caller":"traceutil/trace.go:171","msg":"trace[328958807] transaction","detail":"{read_only:false; response_revision:1865; number_of_response:1; }","duration":"195.496872ms","start":"2026-06-10T15:15:48.996802Z","end":"2026-06-10T15:15:49.192299Z","steps":["trace[328958807] 'process raft request' (duration: 194.772304ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:15:49.19233Z","caller":"traceutil/trace.go:171","msg":"trace[642248144] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"195.675546ms","start":"2026-06-10T15:15:48.996607Z","end":"2026-06-10T15:15:49.192283Z","steps":["trace[642248144] 'process raft request' (duration: 194.925408ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:16:02.803467Z","caller":"traceutil/trace.go:171","msg":"trace[861382732] linearizableReadLoop","detail":"{readStateIndex:2051; appliedIndex:2050; }","duration":"148.503943ms","start":"2026-06-10T15:16:02.654934Z","end":"2026-06-10T15:16:02.803438Z","steps":["trace[861382732] 'read index received' (duration: 148.36807ms)","trace[861382732] 'applied index is now lower than readState.Index' (duration: 134.903µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T15:16:02.803612Z","caller":"traceutil/trace.go:171","msg":"trace[883364491] transaction","detail":"{read_only:false; response_revision:1975; number_of_response:1; }","duration":"149.438918ms","start":"2026-06-10T15:16:02.654125Z","end":"2026-06-10T15:16:02.803564Z","steps":["trace[883364491] 'process raft request' (duration: 149.139841ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:16:02.803764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.795441ms","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-06-10T15:16:02.8038Z","caller":"traceutil/trace.go:171","msg":"trace[1376568277] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1975; }","duration":"148.873823ms","start":"2026-06-10T15:16:02.654918Z","end":"2026-06-10T15:16:02.803791Z","steps":["trace[1376568277] 'agreement among raft nodes before linearized reading' (duration: 148.690538ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:16:02.804214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.137079ms","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-06-10T15:16:02.804359Z","caller":"traceutil/trace.go:171","msg":"trace[387640352] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1975; }","duration":"147.295142ms","start":"2026-06-10T15:16:02.657008Z","end":"2026-06-10T15:16:02.804304Z","steps":["trace[387640352] 'agreement among raft nodes before linearized reading' (duration: 146.928913ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:16:39.277898Z","caller":"traceutil/trace.go:171","msg":"trace[973400428] transaction","detail":"{read_only:false; response_revision:2185; number_of_response:1; }","duration":"104.272581ms","start":"2026-06-10T15:16:39.173589Z","end":"2026-06-10T15:16:39.277861Z","steps":["trace[973400428] 'process raft request' (duration: 85.676683ms)","trace[973400428] 'compare' (duration: 18.443584ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T15:16:45.332639Z","caller":"traceutil/trace.go:171","msg":"trace[1686714066] transaction","detail":"{read_only:false; response_revision:2217; number_of_response:1; }","duration":"135.27186ms","start":"2026-06-10T15:16:45.197322Z","end":"2026-06-10T15:16:45.332594Z","steps":["trace[1686714066] 'process raft request' (duration: 135.059635ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:16:45.609342Z","caller":"traceutil/trace.go:171","msg":"trace[1113995855] transaction","detail":"{read_only:false; response_revision:2220; number_of_response:1; }","duration":"196.392787ms","start":"2026-06-10T15:16:45.411308Z","end":"2026-06-10T15:16:45.607701Z","steps":["trace[1113995855] 'process raft request' (duration: 142.294937ms)","trace[1113995855] 'compare' (duration: 53.897025ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T15:16:45.695189Z","caller":"traceutil/trace.go:171","msg":"trace[2066206340] linearizableReadLoop","detail":"{readStateIndex:2307; appliedIndex:2305; }","duration":"217.244542ms","start":"2026-06-10T15:16:45.477913Z","end":"2026-06-10T15:16:45.695158Z","steps":["trace[2066206340] 'read index received' (duration: 75.704863ms)","trace[2066206340] 'applied index is now lower than readState.Index' (duration: 141.538529ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T15:16:45.695288Z","caller":"traceutil/trace.go:171","msg":"trace[1419480874] transaction","detail":"{read_only:false; response_revision:2221; number_of_response:1; }","duration":"283.929908ms","start":"2026-06-10T15:16:45.411314Z","end":"2026-06-10T15:16:45.695244Z","steps":["trace[1419480874] 'process raft request' (duration: 283.673112ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:16:45.695529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.57233ms","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-06-10T15:16:45.695658Z","caller":"traceutil/trace.go:171","msg":"trace[1341159053] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2221; }","duration":"217.772575ms","start":"2026-06-10T15:16:45.477855Z","end":"2026-06-10T15:16:45.695627Z","steps":["trace[1341159053] 'agreement among raft nodes before linearized reading' (duration: 217.434426ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:17:20.142182Z","caller":"traceutil/trace.go:171","msg":"trace[1375291336] transaction","detail":"{read_only:false; response_revision:2584; number_of_response:1; }","duration":"198.51142ms","start":"2026-06-10T15:17:19.943638Z","end":"2026-06-10T15:17:20.142149Z","steps":["trace[1375291336] 'process raft request' (duration: 198.285755ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:17:20.159894Z","caller":"traceutil/trace.go:171","msg":"trace[1151555751] transaction","detail":"{read_only:false; response_revision:2585; number_of_response:1; }","duration":"109.697317ms","start":"2026-06-10T15:17:20.050164Z","end":"2026-06-10T15:17:20.159862Z","steps":["trace[1151555751] 'process raft request' (duration: 109.478702ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:17:54.27278Z","caller":"traceutil/trace.go:171","msg":"trace[643654536] transaction","detail":"{read_only:false; response_revision:2790; number_of_response:1; }","duration":"118.428058ms","start":"2026-06-10T15:17:54.154322Z","end":"2026-06-10T15:17:54.27275Z","steps":["trace[643654536] 'process raft request' (duration: 118.200452ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:17:54.520952Z","caller":"traceutil/trace.go:171","msg":"trace[785877251] linearizableReadLoop","detail":"{readStateIndex:2898; appliedIndex:2897; }","duration":"160.478934ms","start":"2026-06-10T15:17:54.36044Z","end":"2026-06-10T15:17:54.520919Z","steps":["trace[785877251] 'read index received' (duration: 62.197204ms)","trace[785877251] 'applied index is now lower than readState.Index' (duration: 98.27979ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T15:17:54.521266Z","caller":"traceutil/trace.go:171","msg":"trace[1171019555] transaction","detail":"{read_only:false; response_revision:2791; number_of_response:1; }","duration":"211.65926ms","start":"2026-06-10T15:17:54.309586Z","end":"2026-06-10T15:17:54.521245Z","steps":["trace[1171019555] 'process raft request' (duration: 113.265657ms)","trace[1171019555] 'compare' (duration: 97.652795ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T15:17:54.521528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.064848ms","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-06-10T15:17:54.521616Z","caller":"traceutil/trace.go:171","msg":"trace[975807218] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2791; }","duration":"161.177731ms","start":"2026-06-10T15:17:54.360419Z","end":"2026-06-10T15:17:54.521596Z","steps":["trace[975807218] 'agreement among raft nodes before linearized reading' (duration: 160.867703ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:17:54.521516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.136224ms","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-06-10T15:17:54.521755Z","caller":"traceutil/trace.go:171","msg":"trace[1807171904] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2791; }","duration":"113.443272ms","start":"2026-06-10T15:17:54.408284Z","end":"2026-06-10T15:17:54.521727Z","steps":["trace[1807171904] 'agreement among raft nodes before linearized reading' (duration: 112.972839ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:22:06.58643Z","caller":"traceutil/trace.go:171","msg":"trace[1166765275] transaction","detail":"{read_only:false; response_revision:4913; number_of_response:1; }","duration":"109.175434ms","start":"2026-06-10T15:22:06.477221Z","end":"2026-06-10T15:22:06.586396Z","steps":["trace[1166765275] 'process raft request' (duration: 109.099272ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:22:06.586528Z","caller":"traceutil/trace.go:171","msg":"trace[1177830083] transaction","detail":"{read_only:false; response_revision:4914; number_of_response:1; }","duration":"108.519437ms","start":"2026-06-10T15:22:06.477946Z","end":"2026-06-10T15:22:06.586466Z","steps":["trace[1177830083] 'process raft request' (duration: 108.406225ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:22:06.586644Z","caller":"traceutil/trace.go:171","msg":"trace[323624222] transaction","detail":"{read_only:false; response_revision:4915; number_of_response:1; }","duration":"108.368744ms","start":"2026-06-10T15:22:06.478233Z","end":"2026-06-10T15:22:06.586602Z","steps":["trace[323624222] 'process raft request' (duration: 108.150819ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:22:06.586706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.222261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-06-10T15:22:06.586761Z","caller":"traceutil/trace.go:171","msg":"trace[2088800848] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4916; }","duration":"108.327873ms","start":"2026-06-10T15:22:06.478425Z","end":"2026-06-10T15:22:06.586752Z","steps":["trace[2088800848] 'agreement among raft nodes before linearized reading' (duration: 108.068567ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:22:06.586739Z","caller":"traceutil/trace.go:171","msg":"trace[308284898] transaction","detail":"{read_only:false; response_revision:4916; number_of_response:1; }","duration":"108.22487ms","start":"2026-06-10T15:22:06.478438Z","end":"2026-06-10T15:22:06.586663Z","steps":["trace[308284898] 'process raft request' (duration: 107.970594ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:22:06.586869Z","caller":"traceutil/trace.go:171","msg":"trace[782764814] transaction","detail":"{read_only:false; response_revision:4912; number_of_response:1; }","duration":"110.243751ms","start":"2026-06-10T15:22:06.476609Z","end":"2026-06-10T15:22:06.586853Z","steps":["trace[782764814] 'process raft request' (duration: 88.725111ms)","trace[782764814] 'compare' (duration: 20.824582ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T15:22:06.586453Z","caller":"traceutil/trace.go:171","msg":"trace[1277449010] linearizableReadLoop","detail":"{readStateIndex:5104; appliedIndex:5098; }","duration":"107.971325ms","start":"2026-06-10T15:22:06.478468Z","end":"2026-06-10T15:22:06.58644Z","steps":["trace[1277449010] 'read index received' (duration: 6.19274ms)","trace[1277449010] 'applied index is now lower than readState.Index' (duration: 101.777755ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T15:22:09.694452Z","caller":"traceutil/trace.go:171","msg":"trace[610939450] linearizableReadLoop","detail":"{readStateIndex:5245; appliedIndex:5244; }","duration":"123.893009ms","start":"2026-06-10T15:22:09.570526Z","end":"2026-06-10T15:22:09.694419Z","steps":["trace[610939450] 'read index received' (duration: 123.737415ms)","trace[610939450] 'applied index is now lower than readState.Index' (duration: 153.864µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T15:22:09.694527Z","caller":"traceutil/trace.go:171","msg":"trace[1456460065] transaction","detail":"{read_only:false; response_revision:5052; number_of_response:1; }","duration":"158.669488ms","start":"2026-06-10T15:22:09.535809Z","end":"2026-06-10T15:22:09.694479Z","steps":["trace[1456460065] 'process raft request' (duration: 158.342381ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:22:09.694675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.130814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T15:22:09.694758Z","caller":"traceutil/trace.go:171","msg":"trace[77437480] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:0; response_revision:5052; }","duration":"124.263688ms","start":"2026-06-10T15:22:09.570475Z","end":"2026-06-10T15:22:09.694739Z","steps":["trace[77437480] 'agreement among raft nodes before linearized reading' (duration: 124.087143ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:22:32.709654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.358947ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T15:22:32.709849Z","caller":"traceutil/trace.go:171","msg":"trace[726328636] transaction","detail":"{read_only:false; response_revision:5507; number_of_response:1; }","duration":"267.989645ms","start":"2026-06-10T15:22:32.441831Z","end":"2026-06-10T15:22:32.709821Z","steps":["trace[726328636] 'process raft request' (duration: 150.645333ms)","trace[726328636] 'compare' (duration: 116.06184ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T15:22:32.726771Z","caller":"traceutil/trace.go:171","msg":"trace[840393022] transaction","detail":"{read_only:false; response_revision:5508; number_of_response:1; }","duration":"283.465913ms","start":"2026-06-10T15:22:32.443281Z","end":"2026-06-10T15:22:32.726746Z","steps":["trace[840393022] 'process raft request' (duration: 283.262658ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:22:32.726985Z","caller":"traceutil/trace.go:171","msg":"trace[290826448] transaction","detail":"{read_only:false; response_revision:5509; number_of_response:1; }","duration":"280.825828ms","start":"2026-06-10T15:22:32.446124Z","end":"2026-06-10T15:22:32.72695Z","steps":["trace[290826448] 'process raft request' (duration: 280.542901ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:23:34.661976Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3009} {"level":"info","ts":"2026-06-10T15:23:34.751237Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3009,"took":"87.298213ms","hash":1795983967,"current-db-size-bytes":57450496,"current-db-size":"58 MB","current-db-size-in-use-bytes":31567872,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-10T15:23:34.751321Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1795983967,"revision":3009,"compact-revision":-1} {"level":"info","ts":"2026-06-10T15:28:34.678653Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6078} {"level":"info","ts":"2026-06-10T15:28:34.779389Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6078,"took":"98.124519ms","hash":848135036,"current-db-size-bytes":57450496,"current-db-size":"58 MB","current-db-size-in-use-bytes":21942272,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-06-10T15:28:34.779446Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":848135036,"revision":6078,"compact-revision":3009} {"level":"info","ts":"2026-06-10T15:28:45.470504Z","caller":"traceutil/trace.go:171","msg":"trace[849503980] transaction","detail":"{read_only:false; response_revision:8361; number_of_response:1; }","duration":"106.517283ms","start":"2026-06-10T15:28:45.363957Z","end":"2026-06-10T15:28:45.470474Z","steps":["trace[849503980] 'process raft request' (duration: 96.842187ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:28:47.604256Z","caller":"traceutil/trace.go:171","msg":"trace[125251235] transaction","detail":"{read_only:false; response_revision:8368; number_of_response:1; }","duration":"307.309021ms","start":"2026-06-10T15:28:47.296922Z","end":"2026-06-10T15:28:47.604231Z","steps":["trace[125251235] 'process raft request' (duration: 307.029334ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:28:47.604486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T15:28:47.296897Z","time spent":"307.430354ms","remote":"127.0.0.1:48978","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-06-10T15:28:47.61204Z","caller":"traceutil/trace.go:171","msg":"trace[1473891452] linearizableReadLoop","detail":"{readStateIndex:8667; appliedIndex:8665; }","duration":"301.074149ms","start":"2026-06-10T15:28:47.310944Z","end":"2026-06-10T15:28:47.612018Z","steps":["trace[1473891452] 'read index received' (duration: 292.834329ms)","trace[1473891452] 'applied index is now lower than readState.Index' (duration: 8.23872ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T15:28:47.612145Z","caller":"traceutil/trace.go:171","msg":"trace[2036387980] transaction","detail":"{read_only:false; response_revision:8369; number_of_response:1; }","duration":"310.772815ms","start":"2026-06-10T15:28:47.301336Z","end":"2026-06-10T15:28:47.612109Z","steps":["trace[2036387980] 'process raft request' (duration: 310.500548ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:28:47.612272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.391675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-06-10T15:28:47.612286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.336526ms","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-06-10T15:28:47.612312Z","caller":"traceutil/trace.go:171","msg":"trace[2040851976] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8370; }","duration":"138.498708ms","start":"2026-06-10T15:28:47.473804Z","end":"2026-06-10T15:28:47.612302Z","steps":["trace[2040851976] 'agreement among raft nodes before linearized reading' (duration: 138.363864ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:28:47.612306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T15:28:47.301329Z","time spent":"310.894848ms","remote":"127.0.0.1:48978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T15:28:47.61233Z","caller":"traceutil/trace.go:171","msg":"trace[1885299678] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8370; }","duration":"301.429348ms","start":"2026-06-10T15:28:47.310891Z","end":"2026-06-10T15:28:47.61232Z","steps":["trace[1885299678] 'agreement among raft nodes before linearized reading' (duration: 301.263354ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:28:47.612354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T15:28:47.310869Z","time spent":"301.48014ms","remote":"127.0.0.1:48978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-10T15:28:47.612351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.495109ms","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-06-10T15:28:47.612665Z","caller":"traceutil/trace.go:171","msg":"trace[1549095607] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8370; }","duration":"195.869399ms","start":"2026-06-10T15:28:47.416781Z","end":"2026-06-10T15:28:47.612651Z","steps":["trace[1549095607] 'agreement among raft nodes before linearized reading' (duration: 195.384936ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:28:59.850224Z","caller":"traceutil/trace.go:171","msg":"trace[93688222] transaction","detail":"{read_only:false; response_revision:8431; number_of_response:1; }","duration":"216.469778ms","start":"2026-06-10T15:28:59.633726Z","end":"2026-06-10T15:28:59.850196Z","steps":["trace[93688222] 'process raft request' (duration: 216.284834ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:29:00.011589Z","caller":"traceutil/trace.go:171","msg":"trace[1143206369] transaction","detail":"{read_only:false; response_revision:8432; number_of_response:1; }","duration":"365.558403ms","start":"2026-06-10T15:28:59.646006Z","end":"2026-06-10T15:29:00.011565Z","steps":["trace[1143206369] 'process raft request' (duration: 333.894755ms)","trace[1143206369] 'compare' (duration: 31.471374ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T15:29:00.011735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T15:28:59.645979Z","time spent":"365.683467ms","remote":"127.0.0.1:48978","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-06-10T15:29:00.011766Z","caller":"traceutil/trace.go:171","msg":"trace[1601205060] linearizableReadLoop","detail":"{readStateIndex:8734; appliedIndex:8732; }","duration":"343.882298ms","start":"2026-06-10T15:28:59.667864Z","end":"2026-06-10T15:29:00.011746Z","steps":["trace[1601205060] 'read index received' (duration: 182.32473ms)","trace[1601205060] 'applied index is now lower than readState.Index' (duration: 161.544757ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T15:29:00.011903Z","caller":"traceutil/trace.go:171","msg":"trace[1711845888] transaction","detail":"{read_only:false; response_revision:8433; number_of_response:1; }","duration":"363.79853ms","start":"2026-06-10T15:28:59.648091Z","end":"2026-06-10T15:29:00.011889Z","steps":["trace[1711845888] 'process raft request' (duration: 363.428791ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:29:00.011989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T15:28:59.648067Z","time spent":"363.873832ms","remote":"127.0.0.1:48978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T15:29:00.012159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.303728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-06-10T15:29:00.01216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.424225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-06-10T15:29:00.01217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.076684ms","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-06-10T15:29:00.012198Z","caller":"traceutil/trace.go:171","msg":"trace[2118639720] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8433; }","duration":"344.343699ms","start":"2026-06-10T15:28:59.667845Z","end":"2026-06-10T15:29:00.012189Z","steps":["trace[2118639720] 'agreement among raft nodes before linearized reading' (duration: 344.227807ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:29:00.012217Z","caller":"traceutil/trace.go:171","msg":"trace[1403226339] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8433; }","duration":"338.525958ms","start":"2026-06-10T15:28:59.67368Z","end":"2026-06-10T15:29:00.012206Z","steps":["trace[1403226339] 'agreement among raft nodes before linearized reading' (duration: 338.381124ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:29:00.012244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T15:28:59.6678Z","time spent":"344.437631ms","remote":"127.0.0.1:48978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-10T15:29:00.012252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T15:28:59.673658Z","time spent":"338.58717ms","remote":"127.0.0.1:48978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-10T15:29:00.012251Z","caller":"traceutil/trace.go:171","msg":"trace[610866438] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8433; }","duration":"342.188186ms","start":"2026-06-10T15:28:59.670041Z","end":"2026-06-10T15:29:00.012229Z","steps":["trace[610866438] 'agreement among raft nodes before linearized reading' (duration: 341.968461ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:29:00.012173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.600396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-10T15:29:00.012305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T15:28:59.67003Z","time spent":"342.260978ms","remote":"127.0.0.1:48978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-10T15:29:00.012374Z","caller":"traceutil/trace.go:171","msg":"trace[1016362498] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:8433; }","duration":"184.843592ms","start":"2026-06-10T15:28:59.827488Z","end":"2026-06-10T15:29:00.012331Z","steps":["trace[1016362498] 'agreement among raft nodes before linearized reading' (duration: 184.594626ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:29:28.57227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.072857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-10T15:29:28.572348Z","caller":"traceutil/trace.go:171","msg":"trace[1179382407] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8642; }","duration":"206.20328ms","start":"2026-06-10T15:29:28.36613Z","end":"2026-06-10T15:29:28.572333Z","steps":["trace[1179382407] 'range keys from in-memory index tree' (duration: 205.921673ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:29:28.572355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.834175ms","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-06-10T15:29:28.572429Z","caller":"traceutil/trace.go:171","msg":"trace[666047780] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8642; }","duration":"180.949767ms","start":"2026-06-10T15:29:28.39146Z","end":"2026-06-10T15:29:28.572409Z","steps":["trace[666047780] 'range keys from in-memory index tree' (duration: 180.372943ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:29:28.741764Z","caller":"traceutil/trace.go:171","msg":"trace[685478876] transaction","detail":"{read_only:false; response_revision:8643; number_of_response:1; }","duration":"162.069619ms","start":"2026-06-10T15:29:28.579669Z","end":"2026-06-10T15:29:28.741738Z","steps":["trace[685478876] 'process raft request' (duration: 161.890035ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:29:28.742652Z","caller":"traceutil/trace.go:171","msg":"trace[903937281] transaction","detail":"{read_only:false; response_revision:8644; number_of_response:1; }","duration":"161.881165ms","start":"2026-06-10T15:29:28.580707Z","end":"2026-06-10T15:29:28.742588Z","steps":["trace[903937281] 'process raft request' (duration: 161.551818ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:29:32.277683Z","caller":"traceutil/trace.go:171","msg":"trace[922615576] transaction","detail":"{read_only:false; response_revision:8659; number_of_response:1; }","duration":"145.816025ms","start":"2026-06-10T15:29:32.131845Z","end":"2026-06-10T15:29:32.277661Z","steps":["trace[922615576] 'process raft request' (duration: 145.695572ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:29:32.411298Z","caller":"traceutil/trace.go:171","msg":"trace[167555248] transaction","detail":"{read_only:false; response_revision:8660; number_of_response:1; }","duration":"279.432414ms","start":"2026-06-10T15:29:32.131844Z","end":"2026-06-10T15:29:32.411277Z","steps":["trace[167555248] 'process raft request' (duration: 197.59842ms)","trace[167555248] 'compare' (duration: 81.69005ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T15:29:32.411292Z","caller":"traceutil/trace.go:171","msg":"trace[9672633] linearizableReadLoop","detail":"{readStateIndex:8970; appliedIndex:8968; }","duration":"221.604602ms","start":"2026-06-10T15:29:32.189657Z","end":"2026-06-10T15:29:32.411261Z","steps":["trace[9672633] 'read index received' (duration: 87.892541ms)","trace[9672633] 'applied index is now lower than readState.Index' (duration: 133.710701ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T15:29:32.411436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.766597ms","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-06-10T15:29:32.411507Z","caller":"traceutil/trace.go:171","msg":"trace[1000105562] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8660; }","duration":"221.867209ms","start":"2026-06-10T15:29:32.189617Z","end":"2026-06-10T15:29:32.411484Z","steps":["trace[1000105562] 'agreement among raft nodes before linearized reading' (duration: 221.677674ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:29:32.411532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.830159ms","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-06-10T15:29:32.411611Z","caller":"traceutil/trace.go:171","msg":"trace[1742369770] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8660; }","duration":"221.970761ms","start":"2026-06-10T15:29:32.189623Z","end":"2026-06-10T15:29:32.411594Z","steps":["trace[1742369770] 'agreement among raft nodes before linearized reading' (duration: 221.727996ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:29:32.411643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.765873ms","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-06-10T15:29:32.411706Z","caller":"traceutil/trace.go:171","msg":"trace[339908112] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8660; }","duration":"213.870275ms","start":"2026-06-10T15:29:32.19782Z","end":"2026-06-10T15:29:32.41169Z","steps":["trace[339908112] 'agreement among raft nodes before linearized reading' (duration: 213.66377ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:29:40.90009Z","caller":"traceutil/trace.go:171","msg":"trace[1425589418] transaction","detail":"{read_only:false; response_revision:8749; number_of_response:1; }","duration":"115.448209ms","start":"2026-06-10T15:29:40.784616Z","end":"2026-06-10T15:29:40.900064Z","steps":["trace[1425589418] 'process raft request' (duration: 115.281135ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:29:41.072683Z","caller":"traceutil/trace.go:171","msg":"trace[1755277942] linearizableReadLoop","detail":"{readStateIndex:9064; appliedIndex:9062; }","duration":"259.875801ms","start":"2026-06-10T15:29:40.81277Z","end":"2026-06-10T15:29:41.072646Z","steps":["trace[1755277942] 'read index received' (duration: 87.097361ms)","trace[1755277942] 'applied index is now lower than readState.Index' (duration: 172.77765ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T15:29:41.07286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.072735ms","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-06-10T15:29:41.072892Z","caller":"traceutil/trace.go:171","msg":"trace[287653869] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8750; }","duration":"260.150727ms","start":"2026-06-10T15:29:40.812731Z","end":"2026-06-10T15:29:41.072882Z","steps":["trace[287653869] 'agreement among raft nodes before linearized reading' (duration: 260.042965ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:29:41.073166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.278095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-06-10T15:29:41.07324Z","caller":"traceutil/trace.go:171","msg":"trace[1286936321] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8750; }","duration":"153.419069ms","start":"2026-06-10T15:29:40.919806Z","end":"2026-06-10T15:29:41.073225Z","steps":["trace[1286936321] 'agreement among raft nodes before linearized reading' (duration: 153.06992ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:29:41.073411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.306686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-10T15:29:41.072766Z","caller":"traceutil/trace.go:171","msg":"trace[1171158251] transaction","detail":"{read_only:false; response_revision:8750; number_of_response:1; }","duration":"269.535954ms","start":"2026-06-10T15:29:40.803177Z","end":"2026-06-10T15:29:41.072713Z","steps":["trace[1171158251] 'process raft request' (duration: 269.326459ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:29:41.073499Z","caller":"traceutil/trace.go:171","msg":"trace[742950110] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8750; }","duration":"259.424859ms","start":"2026-06-10T15:29:40.814057Z","end":"2026-06-10T15:29:41.073482Z","steps":["trace[742950110] 'agreement among raft nodes before linearized reading' (duration: 259.197553ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:29:41.189801Z","caller":"traceutil/trace.go:171","msg":"trace[1406961442] transaction","detail":"{read_only:false; response_revision:8752; number_of_response:1; }","duration":"111.234927ms","start":"2026-06-10T15:29:41.078543Z","end":"2026-06-10T15:29:41.189778Z","steps":["trace[1406961442] 'process raft request' (duration: 111.039102ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:29:41.190045Z","caller":"traceutil/trace.go:171","msg":"trace[1426903709] transaction","detail":"{read_only:false; response_revision:8753; number_of_response:1; }","duration":"107.086236ms","start":"2026-06-10T15:29:41.082911Z","end":"2026-06-10T15:29:41.189997Z","steps":["trace[1426903709] 'process raft request' (duration: 106.81532ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:29:41.190083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.731569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T15:29:41.190227Z","caller":"traceutil/trace.go:171","msg":"trace[1669784439] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8753; }","duration":"104.926274ms","start":"2026-06-10T15:29:41.085274Z","end":"2026-06-10T15:29:41.1902Z","steps":["trace[1669784439] 'agreement among raft nodes before linearized reading' (duration: 104.692489ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:29:59.66232Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000241f.wal"} {"level":"info","ts":"2026-06-10T15:31:17.780139Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b6478f0ac5aeb8e1","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-10T15:31:17.799635Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-10T15:31:17.799704Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-10T15:33:34.687843Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8166} {"level":"info","ts":"2026-06-10T15:33:34.756684Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8166,"took":"65.21483ms","hash":2808729950,"current-db-size-bytes":57450496,"current-db-size":"58 MB","current-db-size-in-use-bytes":28221440,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-10T15:33:34.756761Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2808729950,"revision":8166,"compact-revision":6078} {"level":"info","ts":"2026-06-10T15:36:34.68191Z","caller":"traceutil/trace.go:171","msg":"trace[1110992442] linearizableReadLoop","detail":"{readStateIndex:12333; appliedIndex:12332; }","duration":"158.107934ms","start":"2026-06-10T15:36:34.523781Z","end":"2026-06-10T15:36:34.681889Z","steps":["trace[1110992442] 'read index received' (duration: 157.90385ms)","trace[1110992442] 'applied index is now lower than readState.Index' (duration: 203.074µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T15:36:34.681972Z","caller":"traceutil/trace.go:171","msg":"trace[1161451321] transaction","detail":"{read_only:false; response_revision:11918; number_of_response:1; }","duration":"169.476152ms","start":"2026-06-10T15:36:34.512465Z","end":"2026-06-10T15:36:34.681941Z","steps":["trace[1161451321] 'process raft request' (duration: 169.191405ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:36:34.682159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.360291ms","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-06-10T15:36:34.682241Z","caller":"traceutil/trace.go:171","msg":"trace[120814065] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:11918; }","duration":"158.488203ms","start":"2026-06-10T15:36:34.523737Z","end":"2026-06-10T15:36:34.682225Z","steps":["trace[120814065] 'agreement among raft nodes before linearized reading' (duration: 158.253948ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:36:34.701753Z","caller":"traceutil/trace.go:171","msg":"trace[1042961928] transaction","detail":"{read_only:false; response_revision:11919; number_of_response:1; }","duration":"129.08574ms","start":"2026-06-10T15:36:34.572643Z","end":"2026-06-10T15:36:34.701728Z","steps":["trace[1042961928] 'process raft request' (duration: 128.887085ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:36:34.821393Z","caller":"traceutil/trace.go:171","msg":"trace[1694454805] transaction","detail":"{read_only:false; response_revision:11921; number_of_response:1; }","duration":"116.35817ms","start":"2026-06-10T15:36:34.704991Z","end":"2026-06-10T15:36:34.821349Z","steps":["trace[1694454805] 'process raft request' (duration: 116.090384ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:36:34.821771Z","caller":"traceutil/trace.go:171","msg":"trace[1432773378] transaction","detail":"{read_only:false; response_revision:11922; number_of_response:1; }","duration":"116.447102ms","start":"2026-06-10T15:36:34.705285Z","end":"2026-06-10T15:36:34.821733Z","steps":["trace[1432773378] 'process raft request' (duration: 116.008352ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:36:35.602334Z","caller":"traceutil/trace.go:171","msg":"trace[709064481] linearizableReadLoop","detail":"{readStateIndex:12341; appliedIndex:12340; }","duration":"249.750676ms","start":"2026-06-10T15:36:35.352558Z","end":"2026-06-10T15:36:35.602309Z","steps":["trace[709064481] 'read index received' (duration: 249.588212ms)","trace[709064481] 'applied index is now lower than readState.Index' (duration: 161.124µs)"],"step_count":2} {"level":"warn","ts":"2026-06-10T15:36:35.602568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.004621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-10T15:36:35.602605Z","caller":"traceutil/trace.go:171","msg":"trace[236118013] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:11926; }","duration":"250.112003ms","start":"2026-06-10T15:36:35.35248Z","end":"2026-06-10T15:36:35.602592Z","steps":["trace[236118013] 'agreement among raft nodes before linearized reading' (duration: 249.921959ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:36:35.60273Z","caller":"traceutil/trace.go:171","msg":"trace[466074414] transaction","detail":"{read_only:false; response_revision:11926; number_of_response:1; }","duration":"285.999555ms","start":"2026-06-10T15:36:35.316718Z","end":"2026-06-10T15:36:35.602718Z","steps":["trace[466074414] 'process raft request' (duration: 285.439932ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:38:34.69472Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10527} {"level":"info","ts":"2026-06-10T15:38:34.774204Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10527,"took":"77.548907ms","hash":2720872095,"current-db-size-bytes":57450496,"current-db-size":"58 MB","current-db-size-in-use-bytes":26296320,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-10T15:38:34.77429Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2720872095,"revision":10527,"compact-revision":8166} {"level":"info","ts":"2026-06-10T15:43:01.985285Z","caller":"traceutil/trace.go:171","msg":"trace[739366549] transaction","detail":"{read_only:false; response_revision:14508; number_of_response:1; }","duration":"169.87568ms","start":"2026-06-10T15:43:01.815382Z","end":"2026-06-10T15:43:01.985257Z","steps":["trace[739366549] 'process raft request' (duration: 169.484811ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:43:15.516719Z","caller":"traceutil/trace.go:171","msg":"trace[1992306326] transaction","detail":"{read_only:false; response_revision:14576; number_of_response:1; }","duration":"113.83327ms","start":"2026-06-10T15:43:15.402856Z","end":"2026-06-10T15:43:15.516689Z","steps":["trace[1992306326] 'process raft request' (duration: 113.654735ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:43:15.711178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.146265ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T15:43:15.711279Z","caller":"traceutil/trace.go:171","msg":"trace[430560250] linearizableReadLoop","detail":"{readStateIndex:15085; appliedIndex:15084; }","duration":"127.402611ms","start":"2026-06-10T15:43:15.583863Z","end":"2026-06-10T15:43:15.711265Z","steps":["trace[430560250] 'read index received' (duration: 9.01963ms)","trace[430560250] 'applied index is now lower than readState.Index' (duration: 118.381561ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T15:43:15.711334Z","caller":"traceutil/trace.go:171","msg":"trace[810150465] transaction","detail":"{read_only:false; response_revision:14577; number_of_response:1; }","duration":"299.361259ms","start":"2026-06-10T15:43:15.411965Z","end":"2026-06-10T15:43:15.711326Z","steps":["trace[810150465] 'process raft request' (duration: 180.994579ms)","trace[810150465] 'compare' (duration: 117.824797ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T15:43:15.711491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.618826ms","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-06-10T15:43:15.711551Z","caller":"traceutil/trace.go:171","msg":"trace[28191502] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:14577; }","duration":"127.717569ms","start":"2026-06-10T15:43:15.583819Z","end":"2026-06-10T15:43:15.711537Z","steps":["trace[28191502] 'agreement among raft nodes before linearized reading' (duration: 127.524553ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:43:15.732701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.167186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-10T15:43:15.732761Z","caller":"traceutil/trace.go:171","msg":"trace[1848867554] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14578; }","duration":"118.271327ms","start":"2026-06-10T15:43:15.614476Z","end":"2026-06-10T15:43:15.732747Z","steps":["trace[1848867554] 'agreement among raft nodes before linearized reading' (duration: 118.069283ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:43:15.733079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.622764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T15:43:15.733102Z","caller":"traceutil/trace.go:171","msg":"trace[509116797] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:14578; }","duration":"113.686276ms","start":"2026-06-10T15:43:15.619409Z","end":"2026-06-10T15:43:15.733095Z","steps":["trace[509116797] 'agreement among raft nodes before linearized reading' (duration: 113.642005ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:43:28.346509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.016649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T15:43:28.346612Z","caller":"traceutil/trace.go:171","msg":"trace[1551587408] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14778; }","duration":"260.168263ms","start":"2026-06-10T15:43:28.086424Z","end":"2026-06-10T15:43:28.346593Z","steps":["trace[1551587408] 'range keys from in-memory index tree' (duration: 259.946038ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:43:28.346713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.091428ms","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-06-10T15:43:28.346792Z","caller":"traceutil/trace.go:171","msg":"trace[871577473] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:14778; }","duration":"316.221651ms","start":"2026-06-10T15:43:28.030545Z","end":"2026-06-10T15:43:28.346767Z","steps":["trace[871577473] 'count revisions from in-memory index tree' (duration: 315.994386ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:43:28.346829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T15:43:28.030519Z","time spent":"316.302224ms","remote":"127.0.0.1:38158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":28,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true "} {"level":"info","ts":"2026-06-10T15:43:28.347247Z","caller":"traceutil/trace.go:171","msg":"trace[1591648462] transaction","detail":"{read_only:false; response_revision:14779; number_of_response:1; }","duration":"134.412512ms","start":"2026-06-10T15:43:28.2128Z","end":"2026-06-10T15:43:28.347212Z","steps":["trace[1591648462] 'process raft request' (duration: 45.646035ms)","trace[1591648462] 'compare' (duration: 88.46786ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T15:43:28.367473Z","caller":"traceutil/trace.go:171","msg":"trace[259416987] transaction","detail":"{read_only:false; response_revision:14780; number_of_response:1; }","duration":"146.63359ms","start":"2026-06-10T15:43:28.220819Z","end":"2026-06-10T15:43:28.367452Z","steps":["trace[259416987] 'process raft request' (duration: 146.480977ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:43:34.70246Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12738} {"level":"info","ts":"2026-06-10T15:43:34.776296Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12738,"took":"71.873226ms","hash":2191877796,"current-db-size-bytes":57450496,"current-db-size":"58 MB","current-db-size-in-use-bytes":28340224,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-10T15:43:34.776357Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2191877796,"revision":12738,"compact-revision":10527} {"level":"info","ts":"2026-06-10T15:44:59.427423Z","caller":"traceutil/trace.go:171","msg":"trace[2129270907] transaction","detail":"{read_only:false; response_revision:15826; number_of_response:1; }","duration":"166.027885ms","start":"2026-06-10T15:44:59.261376Z","end":"2026-06-10T15:44:59.427404Z","steps":["trace[2129270907] 'process raft request' (duration: 165.537352ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:48:34.716283Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14927} {"level":"info","ts":"2026-06-10T15:48:34.819774Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14927,"took":"100.965598ms","hash":1304788499,"current-db-size-bytes":57450496,"current-db-size":"58 MB","current-db-size-in-use-bytes":30670848,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-10T15:48:34.81987Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1304788499,"revision":14927,"compact-revision":12738} {"level":"info","ts":"2026-06-10T15:50:51.789637Z","caller":"traceutil/trace.go:171","msg":"trace[1010564874] transaction","detail":"{read_only:false; response_revision:18399; number_of_response:1; }","duration":"258.440356ms","start":"2026-06-10T15:50:51.531146Z","end":"2026-06-10T15:50:51.789587Z","steps":["trace[1010564874] 'process raft request' (duration: 258.21533ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T15:50:52.101493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.288974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-7wcvh\" ","response":"range_response_count:1 size:20846"} {"level":"info","ts":"2026-06-10T15:50:52.101599Z","caller":"traceutil/trace.go:171","msg":"trace[1108549866] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-7wcvh; range_end:; response_count:1; response_revision:18399; }","duration":"204.451937ms","start":"2026-06-10T15:50:51.897123Z","end":"2026-06-10T15:50:52.101575Z","steps":["trace[1108549866] 'range keys from in-memory index tree' (duration: 204.047038ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T15:53:28.720346Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b6478f0ac5aeb8e1","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-10T15:53:28.726035Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-10T15:53:28.726148Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-10T15:53:34.722863Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17469} {"level":"info","ts":"2026-06-10T15:53:34.819519Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17469,"took":"93.986077ms","hash":2027421808,"current-db-size-bytes":57450496,"current-db-size":"58 MB","current-db-size-in-use-bytes":30109696,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-10T15:53:34.819588Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2027421808,"revision":17469,"compact-revision":14927} {"level":"info","ts":"2026-06-10T15:58:34.728294Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19353} {"level":"info","ts":"2026-06-10T15:58:34.81791Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19353,"took":"86.347801ms","hash":2334601089,"current-db-size-bytes":57450496,"current-db-size":"58 MB","current-db-size-in-use-bytes":24580096,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-06-10T15:58:34.817957Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2334601089,"revision":19353,"compact-revision":17469}