{"level":"warn","ts":"2026-03-18T13:12:14.596596Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"warn","ts":"2026-03-18T13:12:14.596801Z","caller":"etcdmain/config.go:270","msg":"--snapshot-count is deprecated in 3.6 and will be decommissioned in 3.7."} {"level":"info","ts":"2026-03-18T13:12:14.596827Z","caller":"etcdmain/etcd.go:64","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.143:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--feature-gates=InitialCorruptCheck=true","--initial-advertise-peer-urls=https://199.19.213.143:2380","--initial-cluster=controller=https://199.19.213.143:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.143:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.143:2380","--name=controller","--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","--watch-progress-notify-interval=5s"]} {"level":"info","ts":"2026-03-18T13:12:14.597007Z","caller":"etcdmain/etcd.go:124","msg":"Initialize and start etcd server","data-dir":"/var/lib/etcd","dir-type":"empty"} {"level":"warn","ts":"2026-03-18T13:12:14.597147Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-18T13:12:14.597159Z","caller":"embed/etcd.go:138","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.143:2380"]} {"level":"info","ts":"2026-03-18T13:12:14.597188Z","caller":"embed/etcd.go:544","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-03-18T13:12:14.598498Z","caller":"embed/etcd.go:146","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.143:2379"]} {"level":"info","ts":"2026-03-18T13:12:14.598617Z","caller":"embed/etcd.go:323","msg":"starting an etcd server","etcd-version":"3.6.4","git-sha":"5400cdc","go-version":"go1.23.11","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"controller","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.143:2380"],"listen-peer-urls":["https://199.19.213.143:2380"],"advertise-client-urls":["https://199.19.213.143:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.143:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"experimental-local-address":"","cors":["*"],"host-whitelist":["*"],"initial-cluster":"controller=https://199.19.213.143: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,"feature-gates":"InitialCorruptCheck=true","initial-corrupt-check":false,"corrupt-check-time-interval":"0s","compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","discovery-token":"","discovery-endpoints":"","discovery-dial-timeout":"2s","discovery-request-timeout":"5s","discovery-keepalive-time":"2s","discovery-keepalive-timeout":"6s","discovery-insecure-transport":true,"discovery-insecure-skip-tls-verify":false,"discovery-cert":"","discovery-key":"","discovery-cacert":"","discovery-user":"","downgrade-check-interval":"5s","max-learners":1,"v2-deprecation":"write-only"} {"level":"info","ts":"2026-03-18T13:12:14.599805Z","logger":"bbolt","caller":"backend/backend.go:203","msg":"Opening db file (/var/lib/etcd/member/snap/db) with mode -rw------- and with options: {Timeout: 0s, NoGrowSync: false, NoFreelistSync: true, PreLoadFreelist: false, FreelistType: hashmap, ReadOnly: false, MmapFlags: 8000, InitialMmapSize: 10737418240, PageSize: 0, NoSync: false, OpenFile: 0x0, Mlock: false, Logger: 0xc0001364d8}"} {"level":"info","ts":"2026-03-18T13:12:14.604220Z","logger":"bbolt","caller":"bbolt@v1.4.2/db.go:321","msg":"Opening bbolt db (/var/lib/etcd/member/snap/db) successfully"} {"level":"info","ts":"2026-03-18T13:12:14.604274Z","caller":"storage/backend.go:80","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.57082ms"} {"level":"info","ts":"2026-03-18T13:12:14.604301Z","caller":"etcdserver/bootstrap.go:220","msg":"restore consistentIndex","index":0} {"level":"info","ts":"2026-03-18T13:12:14.604331Z","caller":"etcdserver/bootstrap.go:94","msg":"bootstrapping cluster"} {"level":"info","ts":"2026-03-18T13:12:14.604373Z","caller":"etcdserver/bootstrap.go:101","msg":"bootstrapping storage"} {"level":"info","ts":"2026-03-18T13:12:14.611112Z","caller":"etcdserver/bootstrap.go:109","msg":"bootstrapping raft"} {"level":"info","ts":"2026-03-18T13:12:14.611190Z","caller":"etcdserver/bootstrap.go:499","msg":"starting local member","local-member-id":"e5bed6df0e44a0b1","cluster-id":"4e2f0a715964d622"} {"level":"info","ts":"2026-03-18T13:12:14.611221Z","caller":"etcdserver/server.go:312","msg":"bootstrap successfully"} {"level":"info","ts":"2026-03-18T13:12:14.611305Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"e5bed6df0e44a0b1 switched to configuration voters=()"} {"level":"info","ts":"2026-03-18T13:12:14.611349Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"e5bed6df0e44a0b1 became follower at term 0"} {"level":"info","ts":"2026-03-18T13:12:14.611358Z","logger":"raft","caller":"v3@v3.6.0/raft.go:493","msg":"newRaft e5bed6df0e44a0b1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-18T13:12:14.611377Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"e5bed6df0e44a0b1 became follower at term 1"} {"level":"info","ts":"2026-03-18T13:12:14.611409Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"e5bed6df0e44a0b1 switched to configuration voters=(16554905533765951665)"} {"level":"warn","ts":"2026-03-18T13:12:14.619356Z","caller":"auth/store.go:1135","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-18T13:12:14.621591Z","caller":"mvcc/kvstore.go:408","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-18T13:12:14.623980Z","caller":"storage/quota.go:93","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-03-18T13:12:14.624560Z","caller":"etcdserver/server.go:598","msg":"starting etcd server","local-member-id":"e5bed6df0e44a0b1","local-server-version":"3.6.4","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-18T13:12:14.624845Z","caller":"embed/etcd.go:766","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-03-18T13:12:14.624823Z","caller":"etcdserver/server.go:483","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e5bed6df0e44a0b1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-18T13:12:14.625149Z","caller":"fileutil/purge.go:49","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-03-18T13:12:14.625285Z","caller":"fileutil/purge.go:49","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-03-18T13:12:14.625266Z","caller":"embed/etcd.go:640","msg":"serving peer traffic","address":"199.19.213.143:2380"} {"level":"info","ts":"2026-03-18T13:12:14.625370Z","caller":"embed/etcd.go:611","msg":"cmux::serve","address":"199.19.213.143:2380"} {"level":"info","ts":"2026-03-18T13:12:14.625342Z","caller":"fileutil/purge.go:49","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-03-18T13:12:14.625509Z","caller":"embed/etcd.go:292","msg":"now serving peer/client/metrics","local-member-id":"e5bed6df0e44a0b1","initial-advertise-peer-urls":["https://199.19.213.143:2380"],"listen-peer-urls":["https://199.19.213.143:2380"],"advertise-client-urls":["https://199.19.213.143:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.143:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-18T13:12:14.626777Z","caller":"embed/etcd.go:890","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-18T13:12:14.627471Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"e5bed6df0e44a0b1 switched to configuration voters=(16554905533765951665)"} {"level":"info","ts":"2026-03-18T13:12:14.627822Z","caller":"membership/cluster.go:424","msg":"added member","cluster-id":"4e2f0a715964d622","local-member-id":"e5bed6df0e44a0b1","added-peer-id":"e5bed6df0e44a0b1","added-peer-peer-urls":["https://199.19.213.143:2380"],"added-peer-is-learner":false} {"level":"info","ts":"2026-03-18T13:12:14.912474Z","logger":"raft","caller":"v3@v3.6.0/raft.go:988","msg":"e5bed6df0e44a0b1 is starting a new election at term 1"} {"level":"info","ts":"2026-03-18T13:12:14.912556Z","logger":"raft","caller":"v3@v3.6.0/raft.go:930","msg":"e5bed6df0e44a0b1 became pre-candidate at term 1"} {"level":"info","ts":"2026-03-18T13:12:14.912648Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"e5bed6df0e44a0b1 received MsgPreVoteResp from e5bed6df0e44a0b1 at term 1"} {"level":"info","ts":"2026-03-18T13:12:14.912674Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"e5bed6df0e44a0b1 has received 1 MsgPreVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-03-18T13:12:14.912706Z","logger":"raft","caller":"v3@v3.6.0/raft.go:912","msg":"e5bed6df0e44a0b1 became candidate at term 2"} {"level":"info","ts":"2026-03-18T13:12:14.999378Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"e5bed6df0e44a0b1 received MsgVoteResp from e5bed6df0e44a0b1 at term 2"} {"level":"info","ts":"2026-03-18T13:12:14.999515Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"e5bed6df0e44a0b1 has received 1 MsgVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-03-18T13:12:14.999635Z","logger":"raft","caller":"v3@v3.6.0/raft.go:970","msg":"e5bed6df0e44a0b1 became leader at term 2"} {"level":"info","ts":"2026-03-18T13:12:14.999746Z","logger":"raft","caller":"v3@v3.6.0/node.go:370","msg":"raft.node: e5bed6df0e44a0b1 elected leader e5bed6df0e44a0b1 at term 2"} {"level":"info","ts":"2026-03-18T13:12:15.002817Z","caller":"etcdserver/server.go:2404","msg":"setting up initial cluster version using v3 API","cluster-version":"3.6"} {"level":"info","ts":"2026-03-18T13:12:15.003826Z","caller":"etcdserver/server.go:1804","msg":"published local member to cluster through raft","local-member-id":"e5bed6df0e44a0b1","local-member-attributes":"{Name:controller ClientURLs:[https://199.19.213.143:2379]}","cluster-id":"4e2f0a715964d622","publish-timeout":"7s"} {"level":"info","ts":"2026-03-18T13:12:15.004086Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-18T13:12:15.004214Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-18T13:12:15.004792Z","caller":"membership/cluster.go:682","msg":"set initial cluster version","cluster-id":"4e2f0a715964d622","local-member-id":"e5bed6df0e44a0b1","cluster-version":"3.6"} {"level":"info","ts":"2026-03-18T13:12:15.005777Z","caller":"api/capability.go:76","msg":"enabled capabilities for version","cluster-version":"3.6"} {"level":"info","ts":"2026-03-18T13:12:15.005845Z","caller":"etcdserver/server.go:2424","msg":"cluster version is updated","cluster-version":"3.6"} {"level":"info","ts":"2026-03-18T13:12:15.006099Z","caller":"version/monitor.go:116","msg":"cluster version differs from storage version.","cluster-version":"3.6.0","storage-version":"3.5.0"} {"level":"info","ts":"2026-03-18T13:12:15.006188Z","caller":"schema/migration.go:65","msg":"updated storage version","new-storage-version":"3.6.0"} {"level":"info","ts":"2026-03-18T13:12:15.006399Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-18T13:12:15.006438Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-18T13:12:15.007382Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"warn","ts":"2026-03-18T13:12:15.007813Z","caller":"v3rpc/grpc.go:52","msg":"etcdserver: failed to register grpc metrics","error":"duplicate metrics collector registration attempted"} {"level":"info","ts":"2026-03-18T13:12:15.008098Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-03-18T13:12:15.013231Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.143:2379"} {"level":"info","ts":"2026-03-18T13:12:15.013818Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-03-18T13:12:15.302584Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39536","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.302889Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39554","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.328016Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39582","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.352928Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39608","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.366056Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39632","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.401843Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39668","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.415329Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39680","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.425399Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39706","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.433736Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39740","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.444715Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39756","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.461077Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39782","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.472781Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39792","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.483313Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39810","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.493345Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39824","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.506596Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39842","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.513954Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39860","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.526401Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39874","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.536290Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39882","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.546890Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39912","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.562586Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39932","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.609425Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39950","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.623527Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39964","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.633883Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39994","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.647231Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40018","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.657422Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40050","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.666985Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40062","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.682308Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40076","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.699514Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40090","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.712612Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40120","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.730903Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40140","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.739507Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40160","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.756051Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40188","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.768004Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40218","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.779870Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40234","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.788631Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40250","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.814146Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40258","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.822876Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40272","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.833537Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40288","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.843011Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40318","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.853506Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40350","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.862134Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40380","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.871541Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40392","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.886550Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40416","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.897050Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40434","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.906825Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40460","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.916198Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40470","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.925346Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40492","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.946540Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40510","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.958777Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40536","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.966537Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40552","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.978443Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40580","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:15.988414Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40608","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:16.026182Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40622","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:16.039195Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40648","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:16.044523Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40678","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:16.098003Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40700","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:12:17.049768Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"324.61138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" limit:1 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-18T13:12:17.049921Z","caller":"traceutil/trace.go:172","msg":"trace[1913611721] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:12; }","duration":"324.78808ms","start":"2026-03-18T13:12:16.725105Z","end":"2026-03-18T13:12:17.049894Z","steps":["trace[1913611721] 'agreement among raft nodes before linearized reading' (duration: 30.95474ms)","trace[1913611721] 'range keys from in-memory index tree' (duration: 293.59867ms)"],"step_count":2} {"level":"warn","ts":"2026-03-18T13:12:17.049986Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:16.725100Z","time spent":"324.87096ms","remote":"127.0.0.1:39732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":0,"response size":27,"request content":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" limit:1 "} {"level":"warn","ts":"2026-03-18T13:12:17.051175Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"293.86564ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-03-18T13:12:17.051309Z","caller":"traceutil/trace.go:172","msg":"trace[1836622919] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"331.40203ms","start":"2026-03-18T13:12:16.719889Z","end":"2026-03-18T13:12:17.051291Z","steps":["trace[1836622919] 'process raft request' (duration: 36.24659ms)","trace[1836622919] 'compare' (duration: 293.6044ms)"],"step_count":2} {"level":"warn","ts":"2026-03-18T13:12:17.051409Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:16.719878Z","time spent":"331.50598ms","remote":"127.0.0.1:40704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-18T13:12:17.066516Z","caller":"traceutil/trace.go:172","msg":"trace[603149357] linearizableReadLoop","detail":"{readStateIndex:17; appliedIndex:17; }","duration":"310.50792ms","start":"2026-03-18T13:12:16.755994Z","end":"2026-03-18T13:12:17.066502Z","steps":["trace[603149357] 'read index received' (duration: 310.5028ms)","trace[603149357] 'applied index is now lower than readState.Index' (duration: 3.93µs)"],"step_count":2} {"level":"info","ts":"2026-03-18T13:12:17.066776Z","caller":"traceutil/trace.go:172","msg":"trace[1380453123] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"344.29639ms","start":"2026-03-18T13:12:16.722459Z","end":"2026-03-18T13:12:17.066756Z","steps":["trace[1380453123] 'process raft request' (duration: 344.12135ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:12:17.066915Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:16.722444Z","time spent":"344.41636ms","remote":"127.0.0.1:40418","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":694,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-18T13:12:17.066921Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"328.25411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges\" limit:1 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-18T13:12:17.067276Z","caller":"traceutil/trace.go:172","msg":"trace[1870985001] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"344.62623ms","start":"2026-03-18T13:12:16.722598Z","end":"2026-03-18T13:12:17.067225Z","steps":["trace[1870985001] 'process raft request' (duration: 344.12061ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T13:12:17.067369Z","caller":"traceutil/trace.go:172","msg":"trace[1865033746] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"343.80305ms","start":"2026-03-18T13:12:16.723455Z","end":"2026-03-18T13:12:17.067258Z","steps":["trace[1865033746] 'process raft request' (duration: 343.66929ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T13:12:17.067471Z","caller":"traceutil/trace.go:172","msg":"trace[2103534564] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"342.30502ms","start":"2026-03-18T13:12:16.725145Z","end":"2026-03-18T13:12:17.067450Z","steps":["trace[2103534564] 'process raft request' (duration: 342.25542ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:12:17.067521Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:16.723446Z","time spent":"344.00746ms","remote":"127.0.0.1:40704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-18T13:12:17.067548Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:16.722589Z","time spent":"344.72866ms","remote":"127.0.0.1:40152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":586,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-18T13:12:17.067576Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:16.725141Z","time spent":"342.39428ms","remote":"127.0.0.1:39732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":357,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-18T13:12:17.067658Z","caller":"traceutil/trace.go:172","msg":"trace[201223264] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"343.84454ms","start":"2026-03-18T13:12:16.723559Z","end":"2026-03-18T13:12:17.067404Z","steps":["trace[201223264] 'process raft request' (duration: 343.6312ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T13:12:17.067786Z","caller":"traceutil/trace.go:172","msg":"trace[1251337175] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"342.87536ms","start":"2026-03-18T13:12:16.724896Z","end":"2026-03-18T13:12:17.067771Z","steps":["trace[1251337175] 'process raft request' (duration: 342.46175ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T13:12:17.067822Z","caller":"traceutil/trace.go:172","msg":"trace[464271060] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"342.92897ms","start":"2026-03-18T13:12:16.724868Z","end":"2026-03-18T13:12:17.067797Z","steps":["trace[464271060] 'process raft request' (duration: 342.45207ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:12:17.067867Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:16.724890Z","time spent":"342.94741ms","remote":"127.0.0.1:40704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-18T13:12:17.067924Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:16.724863Z","time spent":"343.02581ms","remote":"127.0.0.1:40704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-18T13:12:17.068074Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:16.723552Z","time spent":"344.22656ms","remote":"127.0.0.1:39772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-18T13:12:17.067837Z","caller":"traceutil/trace.go:172","msg":"trace[726545393] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"342.99917ms","start":"2026-03-18T13:12:16.724811Z","end":"2026-03-18T13:12:17.067810Z","steps":["trace[726545393] 'process raft request' (duration: 342.42119ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T13:12:17.067058Z","caller":"traceutil/trace.go:172","msg":"trace[1235981529] range","detail":"{range_begin:/registry/limitranges; range_end:; response_count:0; response_revision:13; }","duration":"328.40503ms","start":"2026-03-18T13:12:16.738623Z","end":"2026-03-18T13:12:17.067028Z","steps":["trace[1235981529] 'agreement among raft nodes before linearized reading' (duration: 327.99048ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:12:17.069285Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:16.738595Z","time spent":"330.14439ms","remote":"127.0.0.1:39808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":25,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges\" limit:1 "} {"level":"warn","ts":"2026-03-18T13:12:17.069218Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:16.724799Z","time spent":"343.91151ms","remote":"127.0.0.1:40704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-18T13:12:17.117599Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"322.37527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-ho7paesrdksqaoi6iuwwu33dmq\" limit:1 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-03-18T13:12:17.117688Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"237.02824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/controller\" limit:1 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-18T13:12:17.117736Z","caller":"traceutil/trace.go:172","msg":"trace[1210484511] range","detail":"{range_begin:/registry/csinodes/controller; range_end:; response_count:0; response_revision:21; }","duration":"237.08675ms","start":"2026-03-18T13:12:16.880638Z","end":"2026-03-18T13:12:17.117725Z","steps":["trace[1210484511] 'agreement among raft nodes before linearized reading' (duration: 236.98859ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T13:12:17.117727Z","caller":"traceutil/trace.go:172","msg":"trace[266351418] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-ho7paesrdksqaoi6iuwwu33dmq; range_end:; response_count:0; response_revision:21; }","duration":"322.49479ms","start":"2026-03-18T13:12:16.795192Z","end":"2026-03-18T13:12:17.117686Z","steps":["trace[266351418] 'agreement among raft nodes before linearized reading' (duration: 322.28246ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:12:17.118008Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:16.795164Z","time spent":"322.83254ms","remote":"127.0.0.1:40058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/apiserver-ho7paesrdksqaoi6iuwwu33dmq\" limit:1 "} {"level":"info","ts":"2026-03-18T13:12:17.172825Z","caller":"traceutil/trace.go:172","msg":"trace[633288453] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"100.06427ms","start":"2026-03-18T13:12:17.072739Z","end":"2026-03-18T13:12:17.172803Z","steps":["trace[633288453] 'process raft request' (duration: 96.18515ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T13:12:17.172879Z","caller":"traceutil/trace.go:172","msg":"trace[1177348664] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"100.09379ms","start":"2026-03-18T13:12:17.072764Z","end":"2026-03-18T13:12:17.172858Z","steps":["trace[1177348664] 'process raft request' (duration: 99.75748ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T13:12:17.173204Z","caller":"traceutil/trace.go:172","msg":"trace[640543190] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"100.17635ms","start":"2026-03-18T13:12:17.072999Z","end":"2026-03-18T13:12:17.173175Z","steps":["trace[640543190] 'process raft request' (duration: 99.67956ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:12:20.365132Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11579208744890406263,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-18T13:12:20.866634Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11579208744890406263,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-18T13:12:20.979531Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.14351616s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourceslices\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-18T13:12:20.979616Z","caller":"traceutil/trace.go:172","msg":"trace[1470286044] range","detail":"{range_begin:/registry/resourceslices; range_end:; response_count:0; response_revision:255; }","duration":"1.14361187s","start":"2026-03-18T13:12:19.835984Z","end":"2026-03-18T13:12:20.979596Z","steps":["trace[1470286044] 'agreement among raft nodes before linearized reading' (duration: 28.70268ms)","trace[1470286044] 'range keys from in-memory index tree' (duration: 1.11478008s)"],"step_count":2} {"level":"warn","ts":"2026-03-18T13:12:20.979659Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:19.835965Z","time spent":"1.14368481s","remote":"127.0.0.1:40684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":0,"response size":28,"request content":"key:\"/registry/resourceslices\" limit:1 "} {"level":"warn","ts":"2026-03-18T13:12:20.980208Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.11534478s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-18T13:12:20.981010Z","caller":"traceutil/trace.go:172","msg":"trace[230448206] transaction","detail":"{read_only:false; response_revision:256; number_of_response:1; }","duration":"1.16693053s","start":"2026-03-18T13:12:19.814049Z","end":"2026-03-18T13:12:20.980980Z","steps":["trace[230448206] 'process raft request' (duration: 50.7486ms)","trace[230448206] 'compare' (duration: 1.11461274s)"],"step_count":2} {"level":"warn","ts":"2026-03-18T13:12:20.981259Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:19.814034Z","time spent":"1.16707929s","remote":"127.0.0.1:39660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":637,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-18T13:12:20.981576Z","caller":"traceutil/trace.go:172","msg":"trace[1356918337] transaction","detail":"{read_only:false; response_revision:257; number_of_response:1; }","duration":"1.16722652s","start":"2026-03-18T13:12:19.814253Z","end":"2026-03-18T13:12:20.981480Z","steps":["trace[1356918337] 'process raft request' (duration: 1.16675984s)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:12:20.981705Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:19.814211Z","time spent":"1.16743293s","remote":"127.0.0.1:40058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":529,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-18T13:12:21.119221Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.25453719s","expected-duration":"1s"} {"level":"info","ts":"2026-03-18T13:12:21.119788Z","caller":"traceutil/trace.go:172","msg":"trace[695726875] linearizableReadLoop","detail":"{readStateIndex:264; appliedIndex:264; }","duration":"1.25493887s","start":"2026-03-18T13:12:19.864653Z","end":"2026-03-18T13:12:21.119592Z","steps":["trace[695726875] 'read index received' (duration: 1.25488919s)","trace[695726875] 'applied index is now lower than readState.Index' (duration: 18.23µs)"],"step_count":2} {"level":"warn","ts":"2026-03-18T13:12:21.139595Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.28925457s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" limit:1 ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-03-18T13:12:21.139696Z","caller":"traceutil/trace.go:172","msg":"trace[1857617480] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:257; }","duration":"1.28936649s","start":"2026-03-18T13:12:19.850299Z","end":"2026-03-18T13:12:21.139665Z","steps":["trace[1857617480] 'agreement among raft nodes before linearized reading' (duration: 1.26944124s)","trace[1857617480] 'range keys from in-memory index tree' (duration: 19.66011ms)"],"step_count":2} {"level":"warn","ts":"2026-03-18T13:12:21.139749Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:19.850281Z","time spent":"1.28945697s","remote":"127.0.0.1:39772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" limit:1 "} {"level":"info","ts":"2026-03-18T13:12:21.139760Z","caller":"traceutil/trace.go:172","msg":"trace[1487326754] transaction","detail":"{read_only:false; response_revision:258; number_of_response:1; }","duration":"1.30637149s","start":"2026-03-18T13:12:19.833256Z","end":"2026-03-18T13:12:21.139627Z","steps":["trace[1487326754] 'process raft request' (duration: 1.28694149s)","trace[1487326754] 'compare' (duration: 19.29916ms)"],"step_count":2} {"level":"warn","ts":"2026-03-18T13:12:21.140122Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:19.833210Z","time spent":"1.30683941s","remote":"127.0.0.1:40440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3482,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-18T13:12:21.274198Z","caller":"traceutil/trace.go:172","msg":"trace[701615436] linearizableReadLoop","detail":"{readStateIndex:265; appliedIndex:265; }","duration":"154.07726ms","start":"2026-03-18T13:12:21.120071Z","end":"2026-03-18T13:12:21.274149Z","steps":["trace[701615436] 'read index received' (duration: 154.05926ms)","trace[701615436] 'applied index is now lower than readState.Index' (duration: 15.6µs)"],"step_count":2} {"level":"warn","ts":"2026-03-18T13:12:21.455459Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"823.69896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-03-18T13:12:21.455505Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"496.98934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-18T13:12:21.455582Z","caller":"traceutil/trace.go:172","msg":"trace[1376944798] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:258; }","duration":"497.09172ms","start":"2026-03-18T13:12:20.958474Z","end":"2026-03-18T13:12:21.455566Z","steps":["trace[1376944798] 'agreement among raft nodes before linearized reading' (duration: 315.82024ms)","trace[1376944798] 'range keys from in-memory index tree' (duration: 181.13232ms)"],"step_count":2} {"level":"warn","ts":"2026-03-18T13:12:21.455621Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:20.958447Z","time spent":"497.1651ms","remote":"127.0.0.1:40058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 "} {"level":"info","ts":"2026-03-18T13:12:21.455971Z","caller":"traceutil/trace.go:172","msg":"trace[339155961] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:258; }","duration":"823.82433ms","start":"2026-03-18T13:12:20.631716Z","end":"2026-03-18T13:12:21.455540Z","steps":["trace[339155961] 'agreement among raft nodes before linearized reading' (duration: 642.61166ms)","trace[339155961] 'range keys from in-memory index tree' (duration: 180.9437ms)"],"step_count":2} {"level":"warn","ts":"2026-03-18T13:12:21.456061Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:20.631691Z","time spent":"824.35101ms","remote":"127.0.0.1:40058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"warn","ts":"2026-03-18T13:12:21.456175Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"181.27521ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-18T13:12:21.456601Z","caller":"traceutil/trace.go:172","msg":"trace[1626449591] transaction","detail":"{read_only:false; response_revision:259; number_of_response:1; }","duration":"1.57807009s","start":"2026-03-18T13:12:19.878505Z","end":"2026-03-18T13:12:21.456575Z","steps":["trace[1626449591] 'process raft request' (duration: 1.39578875s)","trace[1626449591] 'compare' (duration: 181.04759ms)"],"step_count":2} {"level":"warn","ts":"2026-03-18T13:12:21.456699Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:19.878470Z","time spent":"1.57816852s","remote":"127.0.0.1:39872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3308,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-18T13:12:21.456896Z","caller":"traceutil/trace.go:172","msg":"trace[690815759] transaction","detail":"{read_only:false; response_revision:260; number_of_response:1; }","duration":"1.57771271s","start":"2026-03-18T13:12:19.879173Z","end":"2026-03-18T13:12:21.456886Z","steps":["trace[690815759] 'process raft request' (duration: 1.57735509s)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:12:21.456943Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:19.879155Z","time spent":"1.57777003s","remote":"127.0.0.1:39872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5605,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-18T13:12:21.457416Z","caller":"traceutil/trace.go:172","msg":"trace[420324772] transaction","detail":"{read_only:false; response_revision:261; number_of_response:1; }","duration":"1.57784634s","start":"2026-03-18T13:12:19.879544Z","end":"2026-03-18T13:12:21.457390Z","steps":["trace[420324772] 'process raft request' (duration: 1.57710629s)"],"step_count":1} {"level":"info","ts":"2026-03-18T13:12:21.457673Z","caller":"traceutil/trace.go:172","msg":"trace[1017517575] transaction","detail":"{read_only:false; response_revision:263; number_of_response:1; }","duration":"797.7742ms","start":"2026-03-18T13:12:20.659888Z","end":"2026-03-18T13:12:21.457663Z","steps":["trace[1017517575] 'process raft request' (duration: 797.54284ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T13:12:21.457714Z","caller":"traceutil/trace.go:172","msg":"trace[1191817752] transaction","detail":"{read_only:false; response_revision:265; number_of_response:1; }","duration":"312.87706ms","start":"2026-03-18T13:12:21.144829Z","end":"2026-03-18T13:12:21.457706Z","steps":["trace[1191817752] 'process raft request' (duration: 312.68195ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T13:12:21.457501Z","caller":"traceutil/trace.go:172","msg":"trace[1749143037] transaction","detail":"{read_only:false; number_of_response:0; response_revision:261; }","duration":"1.57500831s","start":"2026-03-18T13:12:19.882484Z","end":"2026-03-18T13:12:21.457493Z","steps":["trace[1749143037] 'process raft request' (duration: 1.57471928s)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:12:21.457844Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:19.882466Z","time spent":"1.57535932s","remote":"127.0.0.1:39872","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-18T13:12:21.457884Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:20.659837Z","time spent":"797.86932ms","remote":"127.0.0.1:40058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-18T13:12:21.457537Z","caller":"traceutil/trace.go:172","msg":"trace[116301125] transaction","detail":"{read_only:false; number_of_response:0; response_revision:262; }","duration":"1.51185785s","start":"2026-03-18T13:12:19.945674Z","end":"2026-03-18T13:12:21.457532Z","steps":["trace[116301125] 'process raft request' (duration: 1.51173199s)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:12:21.457952Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:19.945633Z","time spent":"1.51230503s","remote":"127.0.0.1:39870","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-18T13:12:21.458017Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:19.879527Z","time spent":"1.57812955s","remote":"127.0.0.1:39872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4327,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-18T13:12:21.457557Z","caller":"traceutil/trace.go:172","msg":"trace[1843370229] transaction","detail":"{read_only:false; response_revision:262; number_of_response:1; }","duration":"1.5749418s","start":"2026-03-18T13:12:19.882609Z","end":"2026-03-18T13:12:21.457551Z","steps":["trace[1843370229] 'process raft request' (duration: 1.57466972s)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:12:21.458324Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:19.882590Z","time spent":"1.5757023s","remote":"127.0.0.1:39872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5213,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-18T13:12:21.457583Z","caller":"traceutil/trace.go:172","msg":"trace[1980695785] transaction","detail":"{read_only:false; response_revision:264; number_of_response:1; }","duration":"471.93629ms","start":"2026-03-18T13:12:20.985641Z","end":"2026-03-18T13:12:21.457577Z","steps":["trace[1980695785] 'process raft request' (duration: 471.82924ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:12:21.458522Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:20.985612Z","time spent":"472.881ms","remote":"127.0.0.1:39660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":656,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-18T13:12:21.457590Z","caller":"traceutil/trace.go:172","msg":"trace[1091152758] transaction","detail":"{read_only:false; response_revision:266; number_of_response:1; }","duration":"310.30095ms","start":"2026-03-18T13:12:21.147274Z","end":"2026-03-18T13:12:21.457575Z","steps":["trace[1091152758] 'process raft request' (duration: 310.2692ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:12:21.458782Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:21.147233Z","time spent":"311.51767ms","remote":"127.0.0.1:40130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":575,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-18T13:12:21.460938Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:21.144807Z","time spent":"312.92666ms","remote":"127.0.0.1:39918","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":201,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-18T13:12:21.807256Z","caller":"traceutil/trace.go:172","msg":"trace[796142017] transaction","detail":"{read_only:false; response_revision:273; number_of_response:1; }","duration":"281.90161ms","start":"2026-03-18T13:12:21.525319Z","end":"2026-03-18T13:12:21.807221Z","steps":["trace[796142017] 'process raft request' (duration: 255.57964ms)","trace[796142017] 'compare' (duration: 26.2275ms)"],"step_count":2} {"level":"info","ts":"2026-03-18T13:12:21.813823Z","caller":"traceutil/trace.go:172","msg":"trace[1985631050] transaction","detail":"{read_only:false; response_revision:277; number_of_response:1; }","duration":"283.59412ms","start":"2026-03-18T13:12:21.530220Z","end":"2026-03-18T13:12:21.813814Z","steps":["trace[1985631050] 'process raft request' (duration: 283.56474ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T13:12:21.813928Z","caller":"traceutil/trace.go:172","msg":"trace[1281166445] transaction","detail":"{read_only:false; response_revision:275; number_of_response:1; }","duration":"286.31361ms","start":"2026-03-18T13:12:21.527606Z","end":"2026-03-18T13:12:21.813920Z","steps":["trace[1281166445] 'process raft request' (duration: 286.12057ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T13:12:21.814020Z","caller":"traceutil/trace.go:172","msg":"trace[294181127] transaction","detail":"{read_only:false; response_revision:276; number_of_response:1; }","duration":"286.26766ms","start":"2026-03-18T13:12:21.527733Z","end":"2026-03-18T13:12:21.814000Z","steps":["trace[294181127] 'process raft request' (duration: 286.02511ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T13:12:21.814039Z","caller":"traceutil/trace.go:172","msg":"trace[1768449980] transaction","detail":"{read_only:false; response_revision:274; number_of_response:1; }","duration":"287.34765ms","start":"2026-03-18T13:12:21.526685Z","end":"2026-03-18T13:12:21.814033Z","steps":["trace[1768449980] 'process raft request' (duration: 286.99213ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:12:26.032859Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11579208744890406489,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-18T13:12:26.534749Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11579208744890406489,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-18T13:12:27.035298Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11579208744890406489,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-18T13:12:27.099647Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.628655349s","expected-duration":"1s"} {"level":"info","ts":"2026-03-18T13:12:27.099983Z","caller":"traceutil/trace.go:172","msg":"trace[100581962] linearizableReadLoop","detail":"{readStateIndex:347; appliedIndex:347; }","duration":"1.567127509s","start":"2026-03-18T13:12:25.532813Z","end":"2026-03-18T13:12:27.099941Z","steps":["trace[100581962] 'read index received' (duration: 1.567111729s)","trace[100581962] 'applied index is now lower than readState.Index' (duration: 13.77µs)"],"step_count":2} {"level":"warn","ts":"2026-03-18T13:12:27.106837Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.573996899s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-03-18T13:12:27.106943Z","caller":"traceutil/trace.go:172","msg":"trace[514377880] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:337; }","duration":"1.574106779s","start":"2026-03-18T13:12:25.532806Z","end":"2026-03-18T13:12:27.106913Z","steps":["trace[514377880] 'agreement among raft nodes before linearized reading' (duration: 1.567291969s)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:12:27.106995Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:25.532777Z","time spent":"1.574208769s","remote":"127.0.0.1:40058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"warn","ts":"2026-03-18T13:12:27.107152Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.086494379s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" limit:1 ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-03-18T13:12:27.107548Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.643559109s","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-03-18T13:12:27.107659Z","caller":"traceutil/trace.go:172","msg":"trace[324123673] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:337; }","duration":"1.643681079s","start":"2026-03-18T13:12:25.463956Z","end":"2026-03-18T13:12:27.107637Z","steps":["trace[324123673] 'range keys from in-memory index tree' (duration: 1.643500299s)"],"step_count":1} {"level":"info","ts":"2026-03-18T13:12:27.107221Z","caller":"traceutil/trace.go:172","msg":"trace[2132045316] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:337; }","duration":"2.086613649s","start":"2026-03-18T13:12:25.020596Z","end":"2026-03-18T13:12:27.107209Z","steps":["trace[2132045316] 'range keys from in-memory index tree' (duration: 2.086207409s)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:12:27.108351Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:25.020569Z","time spent":"2.087511249s","remote":"127.0.0.1:39918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" limit:1 "} {"level":"info","ts":"2026-03-18T13:12:27.109168Z","caller":"traceutil/trace.go:172","msg":"trace[1427060987] transaction","detail":"{read_only:false; response_revision:338; number_of_response:1; }","duration":"1.638291859s","start":"2026-03-18T13:12:25.470853Z","end":"2026-03-18T13:12:27.109145Z","steps":["trace[1427060987] 'process raft request' (duration: 1.629152249s)"],"step_count":1} {"level":"info","ts":"2026-03-18T13:12:27.109181Z","caller":"traceutil/trace.go:172","msg":"trace[1838675097] transaction","detail":"{read_only:false; response_revision:339; number_of_response:1; }","duration":"1.575195639s","start":"2026-03-18T13:12:25.533955Z","end":"2026-03-18T13:12:27.109150Z","steps":["trace[1838675097] 'process raft request' (duration: 1.575103769s)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:12:27.109348Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:25.470825Z","time spent":"1.638439649s","remote":"127.0.0.1:40058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-18T13:12:27.109360Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:25.533932Z","time spent":"1.575352159s","remote":"127.0.0.1:40058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-18T13:12:27.109368Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.281168289s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-03-18T13:12:27.109427Z","caller":"traceutil/trace.go:172","msg":"trace[978835523] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:339; }","duration":"1.281227239s","start":"2026-03-18T13:12:25.828186Z","end":"2026-03-18T13:12:27.109413Z","steps":["trace[978835523] 'agreement among raft nodes before linearized reading' (duration: 1.281020399s)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:12:27.109482Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:25.828158Z","time spent":"1.281308609s","remote":"127.0.0.1:40058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-03-18T13:12:35.367722Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"152.01638ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-18T13:12:35.367931Z","caller":"traceutil/trace.go:172","msg":"trace[1992372205] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"171.05372ms","start":"2026-03-18T13:12:35.196859Z","end":"2026-03-18T13:12:35.367913Z","steps":["trace[1992372205] 'process raft request' (duration: 170.98222ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T13:12:35.367956Z","caller":"traceutil/trace.go:172","msg":"trace[993554092] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"171.76867ms","start":"2026-03-18T13:12:35.196153Z","end":"2026-03-18T13:12:35.367922Z","steps":["trace[993554092] 'process raft request' (duration: 19.46287ms)","trace[993554092] 'compare' (duration: 151.87364ms)"],"step_count":2} {"level":"info","ts":"2026-03-18T13:12:43.566501Z","caller":"traceutil/trace.go:172","msg":"trace[621669705] linearizableReadLoop","detail":"{readStateIndex:407; appliedIndex:407; }","duration":"103.43699ms","start":"2026-03-18T13:12:43.463022Z","end":"2026-03-18T13:12:43.566459Z","steps":["trace[621669705] 'read index received' (duration: 103.4173ms)","trace[621669705] 'applied index is now lower than readState.Index' (duration: 17.61µs)"],"step_count":2} {"level":"warn","ts":"2026-03-18T13:12:43.566635Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"103.58948ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-18T13:12:43.567144Z","caller":"traceutil/trace.go:172","msg":"trace[1658810809] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"153.75914ms","start":"2026-03-18T13:12:43.413109Z","end":"2026-03-18T13:12:43.566868Z","steps":["trace[1658810809] 'process raft request' (duration: 153.61954ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T13:12:43.567201Z","caller":"traceutil/trace.go:172","msg":"trace[1527892412] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:394; }","duration":"104.15445ms","start":"2026-03-18T13:12:43.463012Z","end":"2026-03-18T13:12:43.567166Z","steps":["trace[1527892412] 'agreement among raft nodes before linearized reading' (duration: 103.53079ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T13:12:43.976139Z","caller":"traceutil/trace.go:172","msg":"trace[2057859311] linearizableReadLoop","detail":"{readStateIndex:408; appliedIndex:408; }","duration":"409.00518ms","start":"2026-03-18T13:12:43.567090Z","end":"2026-03-18T13:12:43.976095Z","steps":["trace[2057859311] 'read index received' (duration: 408.98804ms)","trace[2057859311] 'applied index is now lower than readState.Index' (duration: 15.12µs)"],"step_count":2} {"level":"warn","ts":"2026-03-18T13:12:43.985842Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"515.13672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-18T13:12:43.985970Z","caller":"traceutil/trace.go:172","msg":"trace[1855963089] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:395; }","duration":"515.29015ms","start":"2026-03-18T13:12:43.470655Z","end":"2026-03-18T13:12:43.985945Z","steps":["trace[1855963089] 'agreement among raft nodes before linearized reading' (duration: 505.53307ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T13:12:43.985980Z","caller":"traceutil/trace.go:172","msg":"trace[1558716483] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"571.54584ms","start":"2026-03-18T13:12:43.414398Z","end":"2026-03-18T13:12:43.985944Z","steps":["trace[1558716483] 'process raft request' (duration: 561.695ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:12:43.986035Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:43.470634Z","time spent":"515.38605ms","remote":"127.0.0.1:39566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-18T13:12:43.986171Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:12:43.414375Z","time spent":"571.69821ms","remote":"127.0.0.1:40058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-18T13:13:06.446869Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11579208744890406857,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-18T13:13:06.571580Z","caller":"traceutil/trace.go:172","msg":"trace[1656289225] linearizableReadLoop","detail":"{readStateIndex:525; appliedIndex:525; }","duration":"625.228369ms","start":"2026-03-18T13:13:05.946312Z","end":"2026-03-18T13:13:06.571541Z","steps":["trace[1656289225] 'read index received' (duration: 625.220499ms)","trace[1656289225] 'applied index is now lower than readState.Index' (duration: 6.63µs)"],"step_count":2} {"level":"warn","ts":"2026-03-18T13:13:06.571792Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"625.452279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-18T13:13:06.571891Z","caller":"traceutil/trace.go:172","msg":"trace[1791981475] range","detail":"{range_begin:/registry/secrets; range_end:; response_count:0; response_revision:507; }","duration":"625.563989ms","start":"2026-03-18T13:13:05.946308Z","end":"2026-03-18T13:13:06.571872Z","steps":["trace[1791981475] 'agreement among raft nodes before linearized reading' (duration: 625.373829ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:06.571895Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"490.01476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-03-18T13:13:06.571902Z","caller":"traceutil/trace.go:172","msg":"trace[1564542688] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"880.807809ms","start":"2026-03-18T13:13:05.691052Z","end":"2026-03-18T13:13:06.571860Z","steps":["trace[1564542688] 'process raft request' (duration: 880.570549ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T13:13:06.571977Z","caller":"traceutil/trace.go:172","msg":"trace[1090863182] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:508; }","duration":"490.11299ms","start":"2026-03-18T13:13:06.081848Z","end":"2026-03-18T13:13:06.571961Z","steps":["trace[1090863182] 'agreement among raft nodes before linearized reading' (duration: 489.92092ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:06.571937Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:05.946290Z","time spent":"625.639079ms","remote":"127.0.0.1:39716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":21,"response count":0,"response size":28,"request content":"key:\"/registry/secrets\" limit:1 "} {"level":"warn","ts":"2026-03-18T13:13:06.572024Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:06.081831Z","time spent":"490.18515ms","remote":"127.0.0.1:40058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"warn","ts":"2026-03-18T13:13:06.572096Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:05.691016Z","time spent":"880.986259ms","remote":"127.0.0.1:40058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":425,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-18T13:13:06.572592Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"109.14153ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-18T13:13:06.572720Z","caller":"traceutil/trace.go:172","msg":"trace[167735880] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:508; }","duration":"109.67804ms","start":"2026-03-18T13:13:06.463016Z","end":"2026-03-18T13:13:06.572694Z","steps":["trace[167735880] 'agreement among raft nodes before linearized reading' (duration: 108.93691ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T13:13:06.999016Z","caller":"traceutil/trace.go:172","msg":"trace[140844070] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"421.9923ms","start":"2026-03-18T13:13:06.577000Z","end":"2026-03-18T13:13:06.998992Z","steps":["trace[140844070] 'process raft request' (duration: 348.60741ms)","trace[140844070] 'compare' (duration: 73.21856ms)"],"step_count":2} {"level":"warn","ts":"2026-03-18T13:13:06.999161Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:06.576981Z","time spent":"422.11245ms","remote":"127.0.0.1:40058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":420,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-18T13:13:13.609281Z","caller":"traceutil/trace.go:172","msg":"trace[200187013] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:637; }","duration":"146.455ms","start":"2026-03-18T13:13:13.462765Z","end":"2026-03-18T13:13:13.609220Z","steps":["trace[200187013] 'read index received' (duration: 146.44184ms)","trace[200187013] 'applied index is now lower than readState.Index' (duration: 11.02µs)"],"step_count":2} {"level":"info","ts":"2026-03-18T13:13:13.609470Z","caller":"traceutil/trace.go:172","msg":"trace[470323448] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"247.07042ms","start":"2026-03-18T13:13:13.362376Z","end":"2026-03-18T13:13:13.609447Z","steps":["trace[470323448] 'process raft request' (duration: 246.94996ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:13.609745Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"146.96594ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-18T13:13:13.610272Z","caller":"traceutil/trace.go:172","msg":"trace[1715228343] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:617; }","duration":"147.38063ms","start":"2026-03-18T13:13:13.462758Z","end":"2026-03-18T13:13:13.610138Z","steps":["trace[1715228343] 'agreement among raft nodes before linearized reading' (duration: 146.94905ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:14.453983Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11579208744890407042,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-18T13:13:14.954382Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11579208744890407042,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-18T13:13:15.455333Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11579208744890407042,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-18T13:13:15.955483Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11579208744890407042,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-18T13:13:16.102867Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"2.47358552s","expected-duration":"1s"} {"level":"info","ts":"2026-03-18T13:13:16.103144Z","caller":"traceutil/trace.go:172","msg":"trace[452558285] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:638; }","duration":"2.15026106s","start":"2026-03-18T13:13:13.952855Z","end":"2026-03-18T13:13:16.103116Z","steps":["trace[452558285] 'read index received' (duration: 2.15024758s)","trace[452558285] 'applied index is now lower than readState.Index' (duration: 11.36µs)"],"step_count":2} {"level":"warn","ts":"2026-03-18T13:13:16.394329Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.93140202s","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-03-18T13:13:16.394398Z","caller":"traceutil/trace.go:172","msg":"trace[919379920] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:617; }","duration":"1.93148196s","start":"2026-03-18T13:13:14.462898Z","end":"2026-03-18T13:13:16.394380Z","steps":["trace[919379920] 'range keys from in-memory index tree' (duration: 1.93134142s)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:16.394598Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.44172452s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-hfgvc\" limit:1 ","response":"range_response_count:1 size:19040"} {"level":"info","ts":"2026-03-18T13:13:16.394657Z","caller":"traceutil/trace.go:172","msg":"trace[193902541] range","detail":"{range_begin:/registry/pods/kube-system/cilium-hfgvc; range_end:; response_count:1; response_revision:617; }","duration":"2.44179396s","start":"2026-03-18T13:13:13.952850Z","end":"2026-03-18T13:13:16.394644Z","steps":["trace[193902541] 'agreement among raft nodes before linearized reading' (duration: 2.1504231s)","trace[193902541] 'range keys from in-memory index tree' (duration: 291.19983ms)"],"step_count":2} {"level":"warn","ts":"2026-03-18T13:13:16.394679Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:13.952829Z","time spent":"2.44184465s","remote":"127.0.0.1:39872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":19063,"request content":"key:\"/registry/pods/kube-system/cilium-hfgvc\" limit:1 "} {"level":"warn","ts":"2026-03-18T13:13:16.394671Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"291.44223ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-18T13:13:16.396298Z","caller":"traceutil/trace.go:172","msg":"trace[1900596179] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"3.03008122s","start":"2026-03-18T13:13:13.366127Z","end":"2026-03-18T13:13:16.396209Z","steps":["trace[1900596179] 'process raft request' (duration: 3.02879891s)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:16.396472Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:13.366100Z","time spent":"3.03028184s","remote":"127.0.0.1:39716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036273,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-18T13:13:16.396341Z","caller":"traceutil/trace.go:172","msg":"trace[272632364] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"3.03329229s","start":"2026-03-18T13:13:13.363019Z","end":"2026-03-18T13:13:16.396312Z","steps":["trace[272632364] 'process raft request' (duration: 2.74014012s)","trace[272632364] 'compare' (duration: 291.34ms)"],"step_count":2} {"level":"warn","ts":"2026-03-18T13:13:16.396654Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:13.362993Z","time spent":"3.03361236s","remote":"127.0.0.1:40058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-18T13:13:16.401153Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"543.36966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/servicecidrs\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-18T13:13:16.401344Z","caller":"traceutil/trace.go:172","msg":"trace[631109762] range","detail":"{range_begin:/registry/servicecidrs; range_end:; response_count:0; response_revision:619; }","duration":"543.46549ms","start":"2026-03-18T13:13:15.857752Z","end":"2026-03-18T13:13:16.401218Z","steps":["trace[631109762] 'agreement among raft nodes before linearized reading' (duration: 543.3165ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:16.401587Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:15.857731Z","time spent":"543.82832ms","remote":"127.0.0.1:40152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":26,"response count":0,"response size":28,"request content":"key:\"/registry/servicecidrs\" limit:1 "} {"level":"info","ts":"2026-03-18T13:13:16.401015Z","caller":"traceutil/trace.go:172","msg":"trace[1639362298] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:640; }","duration":"297.77487ms","start":"2026-03-18T13:13:16.103212Z","end":"2026-03-18T13:13:16.400987Z","steps":["trace[1639362298] 'read index received' (duration: 297.75992ms)","trace[1639362298] 'applied index is now lower than readState.Index' (duration: 13.47µs)"],"step_count":2} {"level":"warn","ts":"2026-03-18T13:13:16.660841Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.19124353s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-18T13:13:16.660948Z","caller":"traceutil/trace.go:172","msg":"trace[1625756303] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:619; }","duration":"2.19135602s","start":"2026-03-18T13:13:14.469564Z","end":"2026-03-18T13:13:16.660920Z","steps":["trace[1625756303] 'agreement among raft nodes before linearized reading' (duration: 1.93205716s)","trace[1625756303] 'range keys from in-memory index tree' (duration: 259.1425ms)"],"step_count":2} {"level":"warn","ts":"2026-03-18T13:13:16.660967Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.01253583s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:440"} {"level":"warn","ts":"2026-03-18T13:13:16.661017Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.59493881s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-03-18T13:13:16.661019Z","caller":"traceutil/trace.go:172","msg":"trace[1419325869] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:619; }","duration":"2.01258454s","start":"2026-03-18T13:13:14.648414Z","end":"2026-03-18T13:13:16.660999Z","steps":["trace[1419325869] 'agreement among raft nodes before linearized reading' (duration: 1.75300448s)","trace[1419325869] 'range keys from in-memory index tree' (duration: 259.43278ms)"],"step_count":2} {"level":"warn","ts":"2026-03-18T13:13:16.660995Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:14.469540Z","time spent":"2.19144583s","remote":"127.0.0.1:39566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-18T13:13:16.661079Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:14.648394Z","time spent":"2.01267539s","remote":"127.0.0.1:40058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"info","ts":"2026-03-18T13:13:16.661074Z","caller":"traceutil/trace.go:172","msg":"trace[995012649] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:619; }","duration":"1.59498897s","start":"2026-03-18T13:13:15.066065Z","end":"2026-03-18T13:13:16.661053Z","steps":["trace[995012649] 'agreement among raft nodes before linearized reading' (duration: 1.3353511s)","trace[995012649] 'range keys from in-memory index tree' (duration: 259.47683ms)"],"step_count":2} {"level":"warn","ts":"2026-03-18T13:13:16.660853Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"259.70619ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-03-18T13:13:16.661132Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:15.066040Z","time spent":"1.59507822s","remote":"127.0.0.1:40058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"info","ts":"2026-03-18T13:13:16.661315Z","caller":"traceutil/trace.go:172","msg":"trace[1131310707] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:640; }","duration":"259.23429ms","start":"2026-03-18T13:13:16.402065Z","end":"2026-03-18T13:13:16.661299Z","steps":["trace[1131310707] 'read index received' (duration: 67.72µs)","trace[1131310707] 'applied index is now lower than readState.Index' (duration: 259.16584ms)"],"step_count":2} {"level":"warn","ts":"2026-03-18T13:13:16.661405Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"266.96739ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-18T13:13:16.661421Z","caller":"traceutil/trace.go:172","msg":"trace[1032535342] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:620; }","duration":"266.99549ms","start":"2026-03-18T13:13:16.394420Z","end":"2026-03-18T13:13:16.661416Z","steps":["trace[1032535342] 'agreement among raft nodes before linearized reading' (duration: 266.95778ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T13:13:16.661404Z","caller":"traceutil/trace.go:172","msg":"trace[1451563495] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"1.04649803s","start":"2026-03-18T13:13:15.614888Z","end":"2026-03-18T13:13:16.661386Z","steps":["trace[1451563495] 'process raft request' (duration: 1.04630643s)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:16.661531Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:15.614863Z","time spent":"1.04658516s","remote":"127.0.0.1:40058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-18T13:13:17.161958Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11579208744890407049,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-18T13:13:17.662377Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11579208744890407049,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-18T13:13:18.047757Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.632150799s","expected-duration":"1s"} {"level":"info","ts":"2026-03-18T13:13:18.047985Z","caller":"traceutil/trace.go:172","msg":"trace[850103247] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:642; }","duration":"1.386594289s","start":"2026-03-18T13:13:16.661359Z","end":"2026-03-18T13:13:18.047954Z","steps":["trace[850103247] 'read index received' (duration: 1.386582509s)","trace[850103247] 'applied index is now lower than readState.Index' (duration: 10.29µs)"],"step_count":2} {"level":"warn","ts":"2026-03-18T13:13:19.324688Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.854063929s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-18T13:13:19.324774Z","caller":"traceutil/trace.go:172","msg":"trace[1884133092] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:620; }","duration":"2.854150639s","start":"2026-03-18T13:13:16.470603Z","end":"2026-03-18T13:13:19.324753Z","steps":["trace[1884133092] 'agreement among raft nodes before linearized reading' (duration: 1.577481359s)","trace[1884133092] 'range keys from in-memory index tree' (duration: 1.27653841s)"],"step_count":2} {"level":"warn","ts":"2026-03-18T13:13:19.324810Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:16.470583Z","time spent":"2.854218999s","remote":"127.0.0.1:39548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-18T13:13:19.325026Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.27678058s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-18T13:13:19.325199Z","caller":"traceutil/trace.go:172","msg":"trace[1991325269] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"2.909673449s","start":"2026-03-18T13:13:16.415476Z","end":"2026-03-18T13:13:19.325149Z","steps":["trace[1991325269] 'process raft request' (duration: 1.632675619s)","trace[1991325269] 'compare' (duration: 1.27655853s)"],"step_count":2} {"level":"info","ts":"2026-03-18T13:13:19.325366Z","caller":"traceutil/trace.go:172","msg":"trace[1573954594] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"2.659302289s","start":"2026-03-18T13:13:16.666040Z","end":"2026-03-18T13:13:19.325342Z","steps":["trace[1573954594] 'process raft request' (duration: 2.659259209s)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:19.325414Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:16.415455Z","time spent":"2.909869209s","remote":"127.0.0.1:39872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19197,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-18T13:13:19.325450Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:16.666017Z","time spent":"2.659392589s","remote":"127.0.0.1:40058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":425,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-18T13:13:19.325489Z","caller":"traceutil/trace.go:172","msg":"trace[953310987] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:642; }","duration":"1.27740956s","start":"2026-03-18T13:13:18.048066Z","end":"2026-03-18T13:13:19.325476Z","steps":["trace[953310987] 'read index received' (duration: 91.98558ms)","trace[953310987] 'applied index is now lower than readState.Index' (duration: 1.18542291s)"],"step_count":2} {"level":"warn","ts":"2026-03-18T13:13:19.325574Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.662900019s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-18T13:13:19.325611Z","caller":"traceutil/trace.go:172","msg":"trace[36360354] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:624; }","duration":"2.662939129s","start":"2026-03-18T13:13:16.662659Z","end":"2026-03-18T13:13:19.325599Z","steps":["trace[36360354] 'agreement among raft nodes before linearized reading' (duration: 2.662870009s)"],"step_count":1} {"level":"info","ts":"2026-03-18T13:13:19.325443Z","caller":"traceutil/trace.go:172","msg":"trace[710106542] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"2.864383899s","start":"2026-03-18T13:13:16.461041Z","end":"2026-03-18T13:13:19.325425Z","steps":["trace[710106542] 'process raft request' (duration: 2.864078009s)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:19.325716Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:16.461015Z","time spent":"2.864661769s","remote":"127.0.0.1:40530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-18T13:13:19.325765Z","caller":"traceutil/trace.go:172","msg":"trace[820463477] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"2.659921509s","start":"2026-03-18T13:13:16.665830Z","end":"2026-03-18T13:13:19.325752Z","steps":["trace[820463477] 'process raft request' (duration: 2.659383339s)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:19.325856Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:16.665804Z","time spent":"2.659990549s","remote":"127.0.0.1:40058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":420,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-18T13:13:19.325910Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.52948162s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-18T13:13:19.325954Z","caller":"traceutil/trace.go:172","msg":"trace[1457519599] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:624; }","duration":"1.52952467s","start":"2026-03-18T13:13:17.796417Z","end":"2026-03-18T13:13:19.325942Z","steps":["trace[1457519599] 'agreement among raft nodes before linearized reading' (duration: 1.52945082s)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:19.325991Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:17.796396Z","time spent":"1.52958587s","remote":"127.0.0.1:39566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-18T13:13:19.326311Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.18099804s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-18T13:13:19.326352Z","caller":"traceutil/trace.go:172","msg":"trace[955812490] range","detail":"{range_begin:/registry/controllers; range_end:; response_count:0; response_revision:624; }","duration":"2.18103944s","start":"2026-03-18T13:13:17.145301Z","end":"2026-03-18T13:13:19.326341Z","steps":["trace[955812490] 'agreement among raft nodes before linearized reading' (duration: 2.18096895s)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:19.326380Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:17.145286Z","time spent":"2.18108795s","remote":"127.0.0.1:39948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":25,"response count":0,"response size":28,"request content":"key:\"/registry/controllers\" limit:1 "} {"level":"warn","ts":"2026-03-18T13:13:19.326395Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.16946965s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-18T13:13:19.326447Z","caller":"traceutil/trace.go:172","msg":"trace[827620968] range","detail":"{range_begin:/registry/clusterroles; range_end:; response_count:0; response_revision:624; }","duration":"2.16952347s","start":"2026-03-18T13:13:17.156911Z","end":"2026-03-18T13:13:19.326434Z","steps":["trace[827620968] 'agreement among raft nodes before linearized reading' (duration: 2.16943404s)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:19.326486Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:17.156899Z","time spent":"2.16957607s","remote":"127.0.0.1:40236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":26,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles\" limit:1 "} {"level":"warn","ts":"2026-03-18T13:13:19.326503Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.38401384s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-18T13:13:19.326548Z","caller":"traceutil/trace.go:172","msg":"trace[695718902] range","detail":"{range_begin:/registry/jobs; range_end:; response_count:0; response_revision:624; }","duration":"2.38405881s","start":"2026-03-18T13:13:16.942476Z","end":"2026-03-18T13:13:19.326535Z","steps":["trace[695718902] 'agreement among raft nodes before linearized reading' (duration: 2.38398102s)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:19.326583Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:16.942452Z","time spent":"2.38412111s","remote":"127.0.0.1:39980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/jobs\" limit:1 "} {"level":"warn","ts":"2026-03-18T13:13:19.326652Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.49271375s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-18T13:13:19.326685Z","caller":"traceutil/trace.go:172","msg":"trace[862175254] range","detail":"{range_begin:/registry/daemonsets; range_end:; response_count:0; response_revision:624; }","duration":"2.49274817s","start":"2026-03-18T13:13:16.833928Z","end":"2026-03-18T13:13:19.326676Z","steps":["trace[862175254] 'agreement among raft nodes before linearized reading' (duration: 2.49269557s)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:19.326709Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:16.833903Z","time spent":"2.49280081s","remote":"127.0.0.1:40476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":24,"response count":0,"response size":28,"request content":"key:\"/registry/daemonsets\" limit:1 "} {"level":"warn","ts":"2026-03-18T13:13:19.327221Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.00512335s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.143\" limit:1 ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-03-18T13:13:19.327305Z","caller":"traceutil/trace.go:172","msg":"trace[874405839] range","detail":"{range_begin:/registry/masterleases/199.19.213.143; range_end:; response_count:1; response_revision:625; }","duration":"1.00523939s","start":"2026-03-18T13:13:18.322051Z","end":"2026-03-18T13:13:19.327290Z","steps":["trace[874405839] 'agreement among raft nodes before linearized reading' (duration: 1.00503776s)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:19.327338Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:18.322030Z","time spent":"1.00529914s","remote":"127.0.0.1:39592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.143\" limit:1 "} {"level":"info","ts":"2026-03-18T13:13:19.327645Z","caller":"traceutil/trace.go:172","msg":"trace[1576893617] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"922.86713ms","start":"2026-03-18T13:13:18.404763Z","end":"2026-03-18T13:13:19.327630Z","steps":["trace[1576893617] 'process raft request' (duration: 922.2572ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:19.327711Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:18.404738Z","time spent":"922.93456ms","remote":"127.0.0.1:40058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-18T13:13:19.328425Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"337.00443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-18T13:13:19.328493Z","caller":"traceutil/trace.go:172","msg":"trace[2117508947] range","detail":"{range_begin:/registry/poddisruptionbudgets; range_end:; response_count:0; response_revision:625; }","duration":"337.0856ms","start":"2026-03-18T13:13:18.991393Z","end":"2026-03-18T13:13:19.328479Z","steps":["trace[2117508947] 'agreement among raft nodes before linearized reading' (duration: 336.95209ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:19.328500Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"849.74815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-18T13:13:19.328524Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:18.991371Z","time spent":"337.14724ms","remote":"127.0.0.1:40172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/poddisruptionbudgets\" limit:1 "} {"level":"info","ts":"2026-03-18T13:13:19.328530Z","caller":"traceutil/trace.go:172","msg":"trace[2129123837] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:625; }","duration":"849.77593ms","start":"2026-03-18T13:13:18.478746Z","end":"2026-03-18T13:13:19.328522Z","steps":["trace[2129123837] 'agreement among raft nodes before linearized reading' (duration: 849.7339ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:19.328551Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:18.478737Z","time spent":"849.81072ms","remote":"127.0.0.1:39548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-18T13:13:19.328663Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"641.33686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-18T13:13:19.328693Z","caller":"traceutil/trace.go:172","msg":"trace[1203194215] range","detail":"{range_begin:/registry/secrets; range_end:; response_count:0; response_revision:625; }","duration":"641.36565ms","start":"2026-03-18T13:13:18.687320Z","end":"2026-03-18T13:13:19.328686Z","steps":["trace[1203194215] 'agreement among raft nodes before linearized reading' (duration: 641.32488ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:19.328711Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:18.687302Z","time spent":"641.40391ms","remote":"127.0.0.1:39716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":21,"response count":0,"response size":28,"request content":"key:\"/registry/secrets\" limit:1 "} {"level":"warn","ts":"2026-03-18T13:13:19.328225Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"221.07483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-18T13:13:19.329700Z","caller":"traceutil/trace.go:172","msg":"trace[1204630053] range","detail":"{range_begin:/registry/flowschemas; range_end:; response_count:0; response_revision:625; }","duration":"222.55032ms","start":"2026-03-18T13:13:19.107140Z","end":"2026-03-18T13:13:19.329690Z","steps":["trace[1204630053] 'agreement among raft nodes before linearized reading' (duration: 221.04803ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T13:13:19.330402Z","caller":"traceutil/trace.go:172","msg":"trace[113444547] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"607.72871ms","start":"2026-03-18T13:13:18.722654Z","end":"2026-03-18T13:13:19.330383Z","steps":["trace[113444547] 'process raft request' (duration: 607.67672ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:19.330544Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:18.722625Z","time spent":"607.84788ms","remote":"127.0.0.1:40058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":675,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-18T13:13:19.330756Z","caller":"traceutil/trace.go:172","msg":"trace[1119840567] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"856.07745ms","start":"2026-03-18T13:13:18.474663Z","end":"2026-03-18T13:13:19.330741Z","steps":["trace[1119840567] 'process raft request' (duration: 855.46121ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:19.330819Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:18.474646Z","time spent":"856.14144ms","remote":"127.0.0.1:39660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":769,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-18T13:13:19.330912Z","caller":"traceutil/trace.go:172","msg":"trace[1213460130] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"643.41335ms","start":"2026-03-18T13:13:18.687486Z","end":"2026-03-18T13:13:19.330899Z","steps":["trace[1213460130] 'process raft request' (duration: 642.74439ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:19.330997Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:18.687459Z","time spent":"643.48503ms","remote":"127.0.0.1:40058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":466,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-18T13:13:20.147099Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"172.60199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-hfgvc\" limit:1 ","response":"range_response_count:1 size:19212"} {"level":"info","ts":"2026-03-18T13:13:20.147179Z","caller":"traceutil/trace.go:172","msg":"trace[829206766] range","detail":"{range_begin:/registry/pods/kube-system/cilium-hfgvc; range_end:; response_count:1; response_revision:637; }","duration":"172.68524ms","start":"2026-03-18T13:13:19.974469Z","end":"2026-03-18T13:13:20.147154Z","steps":["trace[829206766] 'range keys from in-memory index tree' (duration: 172.39498ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T13:13:20.147161Z","caller":"traceutil/trace.go:172","msg":"trace[1451694751] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"172.37407ms","start":"2026-03-18T13:13:19.974754Z","end":"2026-03-18T13:13:20.147128Z","steps":["trace[1451694751] 'process raft request' (duration: 106.71273ms)","trace[1451694751] 'compare' (duration: 65.42494ms)"],"step_count":2} {"level":"warn","ts":"2026-03-18T13:13:21.554942Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"222.08805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-03-18T13:13:21.555024Z","caller":"traceutil/trace.go:172","msg":"trace[909530511] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:648; }","duration":"222.18944ms","start":"2026-03-18T13:13:21.332816Z","end":"2026-03-18T13:13:21.555005Z","steps":["trace[909530511] 'range keys from in-memory index tree' (duration: 221.89901ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T13:13:21.555313Z","caller":"traceutil/trace.go:172","msg":"trace[652038938] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"220.23948ms","start":"2026-03-18T13:13:21.334924Z","end":"2026-03-18T13:13:21.555163Z","steps":["trace[652038938] 'process raft request' (duration: 216.08658ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:21.555460Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"221.89832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-03-18T13:13:21.555629Z","caller":"traceutil/trace.go:172","msg":"trace[486032889] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:648; }","duration":"222.09854ms","start":"2026-03-18T13:13:21.333501Z","end":"2026-03-18T13:13:21.555600Z","steps":["trace[486032889] 'range keys from in-memory index tree' (duration: 221.59747ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T13:13:21.558037Z","caller":"traceutil/trace.go:172","msg":"trace[1736195990] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"220.65434ms","start":"2026-03-18T13:13:21.337361Z","end":"2026-03-18T13:13:21.558016Z","steps":["trace[1736195990] 'process raft request' (duration: 220.13934ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:23.945693Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34668","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:13:24.014472Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34686","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:13:24.039402Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34690","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:13:24.086460Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34720","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:13:24.104893Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34732","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:13:24.121149Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34756","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:13:24.169839Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34782","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:13:24.192526Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34812","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:13:24.217796Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34826","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:13:24.313658Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34852","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:13:24.345480Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34868","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:13:24.364695Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34872","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:13:24.409936Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34902","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:13:24.492884Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34936","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:13:24.535062Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34946","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:13:24.560870Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:34984","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:13:24.587316Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35008","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:13:24.601019Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35012","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:13:24.715362Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35038","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:13:24.732596Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35046","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:13:24.754529Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35070","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:13:24.772855Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35084","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:13:24.789548Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35088","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:13:28.862994Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35128","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:13:30.509695Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35136","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:13:30.525211Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35144","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:13:30.645589Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35156","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:13:30.678949Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35184","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:13:30.813873Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:35210","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:13:32.523799Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54086","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:13:44.963557Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11579208744890407601,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-18T13:13:45.379135Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.194356919s","expected-duration":"1s"} {"level":"info","ts":"2026-03-18T13:13:45.379440Z","caller":"traceutil/trace.go:172","msg":"trace[224030113] linearizableReadLoop","detail":"{readStateIndex:870; appliedIndex:870; }","duration":"916.482619ms","start":"2026-03-18T13:13:44.462925Z","end":"2026-03-18T13:13:45.379407Z","steps":["trace[224030113] 'read index received' (duration: 916.475969ms)","trace[224030113] 'applied index is now lower than readState.Index' (duration: 4.93µs)"],"step_count":2} {"level":"warn","ts":"2026-03-18T13:13:45.380191Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"909.705509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-18T13:13:45.380336Z","caller":"traceutil/trace.go:172","msg":"trace[1383331563] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:840; }","duration":"909.842479ms","start":"2026-03-18T13:13:44.470459Z","end":"2026-03-18T13:13:45.380301Z","steps":["trace[1383331563] 'agreement among raft nodes before linearized reading' (duration: 909.164219ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:45.380395Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:44.470429Z","time spent":"909.956859ms","remote":"127.0.0.1:39566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-18T13:13:45.380737Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"100.177399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-18T13:13:45.379665Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"916.705519ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-18T13:13:45.381145Z","caller":"traceutil/trace.go:172","msg":"trace[1850138431] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:839; }","duration":"918.200469ms","start":"2026-03-18T13:13:44.462918Z","end":"2026-03-18T13:13:45.381119Z","steps":["trace[1850138431] 'agreement among raft nodes before linearized reading' (duration: 916.624909ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:45.381219Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"579.111279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-18T13:13:45.381300Z","caller":"traceutil/trace.go:172","msg":"trace[1690376561] range","detail":"{range_begin:/registry/controllerrevisions; range_end:; response_count:0; response_revision:840; }","duration":"579.189619ms","start":"2026-03-18T13:13:44.802094Z","end":"2026-03-18T13:13:45.381284Z","steps":["trace[1690376561] 'agreement among raft nodes before linearized reading' (duration: 579.074039ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:45.381352Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:44.802075Z","time spent":"579.269099ms","remote":"127.0.0.1:40502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":33,"response count":0,"response size":28,"request content":"key:\"/registry/controllerrevisions\" limit:1 "} {"level":"info","ts":"2026-03-18T13:13:45.381127Z","caller":"traceutil/trace.go:172","msg":"trace[1255285823] range","detail":"{range_begin:/registry/services/endpoints; range_end:; response_count:0; response_revision:840; }","duration":"100.617469ms","start":"2026-03-18T13:13:45.280452Z","end":"2026-03-18T13:13:45.381070Z","steps":["trace[1255285823] 'agreement among raft nodes before linearized reading' (duration: 99.250289ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:45.381795Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"830.723429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" keys_only:true ","response":"range_response_count:74 size:6503"} {"level":"info","ts":"2026-03-18T13:13:45.381871Z","caller":"traceutil/trace.go:172","msg":"trace[885289149] transaction","detail":"{read_only:false; response_revision:840; number_of_response:1; }","duration":"1.197216319s","start":"2026-03-18T13:13:44.184631Z","end":"2026-03-18T13:13:45.381847Z","steps":["trace[885289149] 'process raft request' (duration: 1.194850129s)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:45.382008Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:44.184604Z","time spent":"1.197327299s","remote":"127.0.0.1:39872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4550,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-18T13:13:45.382026Z","caller":"traceutil/trace.go:172","msg":"trace[2118595002] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:74; response_revision:840; }","duration":"830.799279ms","start":"2026-03-18T13:13:44.551053Z","end":"2026-03-18T13:13:45.381853Z","steps":["trace[2118595002] 'agreement among raft nodes before linearized reading' (duration: 829.113669ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:45.382310Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:44.551033Z","time spent":"831.255989ms","remote":"127.0.0.1:39660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":74,"response size":6526,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" keys_only:true "} {"level":"warn","ts":"2026-03-18T13:13:45.836440Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"452.61116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-18T13:13:45.836503Z","caller":"traceutil/trace.go:172","msg":"trace[694808630] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:840; }","duration":"452.6819ms","start":"2026-03-18T13:13:45.383807Z","end":"2026-03-18T13:13:45.836489Z","steps":["trace[694808630] 'range keys from in-memory index tree' (duration: 452.35028ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:45.836530Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-03-18T13:13:45.383791Z","time spent":"452.73357ms","remote":"127.0.0.1:39548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-03-18T13:13:45.837083Z","caller":"traceutil/trace.go:172","msg":"trace[750268692] linearizableReadLoop","detail":"{readStateIndex:871; appliedIndex:871; }","duration":"169.61301ms","start":"2026-03-18T13:13:45.667437Z","end":"2026-03-18T13:13:45.837050Z","steps":["trace[750268692] 'read index received' (duration: 169.59495ms)","trace[750268692] 'applied index is now lower than readState.Index' (duration: 14.85µs)"],"step_count":2} {"level":"warn","ts":"2026-03-18T13:13:45.837227Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"169.78807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-03-18T13:13:45.837342Z","caller":"traceutil/trace.go:172","msg":"trace[638216429] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:840; }","duration":"169.9024ms","start":"2026-03-18T13:13:45.667430Z","end":"2026-03-18T13:13:45.837332Z","steps":["trace[638216429] 'agreement among raft nodes before linearized reading' (duration: 169.68936ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T13:13:45.837377Z","caller":"traceutil/trace.go:172","msg":"trace[447484886] transaction","detail":"{read_only:false; response_revision:841; number_of_response:1; }","duration":"201.22447ms","start":"2026-03-18T13:13:45.636131Z","end":"2026-03-18T13:13:45.837355Z","steps":["trace[447484886] 'process raft request' (duration: 201.00572ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:45.837584Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"373.5449ms","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-03-18T13:13:45.837704Z","caller":"traceutil/trace.go:172","msg":"trace[1421446905] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:840; }","duration":"374.68927ms","start":"2026-03-18T13:13:45.462991Z","end":"2026-03-18T13:13:45.837680Z","steps":["trace[1421446905] 'range keys from in-memory index tree' (duration: 373.52214ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:45.853457Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"148.74349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-03-18T13:13:45.853512Z","caller":"traceutil/trace.go:172","msg":"trace[972653287] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:841; }","duration":"148.80072ms","start":"2026-03-18T13:13:45.704699Z","end":"2026-03-18T13:13:45.853500Z","steps":["trace[972653287] 'agreement among raft nodes before linearized reading' (duration: 148.66274ms)"],"step_count":1} {"level":"info","ts":"2026-03-18T13:13:45.853653Z","caller":"traceutil/trace.go:172","msg":"trace[1205122295] transaction","detail":"{read_only:false; response_revision:842; number_of_response:1; }","duration":"205.53799ms","start":"2026-03-18T13:13:45.648088Z","end":"2026-03-18T13:13:45.853626Z","steps":["trace[1205122295] 'process raft request' (duration: 205.25262ms)"],"step_count":1} {"level":"warn","ts":"2026-03-18T13:13:55.864767Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:45192","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:13:55.905080Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:45196","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:13:55.920175Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:45226","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-03-18T13:13:55.932454Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:45242","server-name":"","error":"EOF"}