{"level":"warn","ts":"2026-04-18T17:53:54.160331Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"warn","ts":"2026-04-18T17:53:54.160995Z","caller":"etcdmain/config.go:270","msg":"--snapshot-count is deprecated in 3.6 and will be decommissioned in 3.7."} {"level":"info","ts":"2026-04-18T17:53:54.161051Z","caller":"etcdmain/etcd.go:64","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.105: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.105:2380","--initial-cluster=controller-1=https://199.19.213.105:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.105:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.105:2380","--name=controller-1","--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-04-18T17:53:54.161222Z","caller":"etcdmain/etcd.go:124","msg":"Initialize and start etcd server","data-dir":"/var/lib/etcd","dir-type":"empty"} {"level":"warn","ts":"2026-04-18T17:53:54.161243Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-18T17:53:54.161335Z","caller":"embed/etcd.go:138","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.105:2380"]} {"level":"info","ts":"2026-04-18T17:53:54.161513Z","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-04-18T17:53:54.162111Z","caller":"embed/etcd.go:146","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.105:2379"]} {"level":"info","ts":"2026-04-18T17:53:54.162322Z","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-1","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.105:2380"],"listen-peer-urls":["https://199.19.213.105:2380"],"advertise-client-urls":["https://199.19.213.105:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.105:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"experimental-local-address":"","cors":["*"],"host-whitelist":["*"],"initial-cluster":"controller-1=https://199.19.213.105: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-04-18T17:53:54.177281Z","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: 0xc000078ce0}"} {"level":"info","ts":"2026-04-18T17:53:54.191158Z","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-04-18T17:53:54.191401Z","caller":"storage/backend.go:80","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"14.369852ms"} {"level":"info","ts":"2026-04-18T17:53:54.191441Z","caller":"etcdserver/bootstrap.go:220","msg":"restore consistentIndex","index":0} {"level":"info","ts":"2026-04-18T17:53:54.191535Z","caller":"etcdserver/bootstrap.go:94","msg":"bootstrapping cluster"} {"level":"info","ts":"2026-04-18T17:53:54.191760Z","caller":"etcdserver/bootstrap.go:101","msg":"bootstrapping storage"} {"level":"info","ts":"2026-04-18T17:53:54.209242Z","caller":"etcdserver/bootstrap.go:109","msg":"bootstrapping raft"} {"level":"info","ts":"2026-04-18T17:53:54.209457Z","caller":"etcdserver/bootstrap.go:499","msg":"starting local member","local-member-id":"eb6db91b2c71522f","cluster-id":"f43476f3367c14fb"} {"level":"info","ts":"2026-04-18T17:53:54.209569Z","caller":"etcdserver/server.go:312","msg":"bootstrap successfully"} {"level":"info","ts":"2026-04-18T17:53:54.209781Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"eb6db91b2c71522f switched to configuration voters=()"} {"level":"info","ts":"2026-04-18T17:53:54.209970Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"eb6db91b2c71522f became follower at term 0"} {"level":"info","ts":"2026-04-18T17:53:54.209989Z","logger":"raft","caller":"v3@v3.6.0/raft.go:493","msg":"newRaft eb6db91b2c71522f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-18T17:53:54.210071Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"eb6db91b2c71522f became follower at term 1"} {"level":"info","ts":"2026-04-18T17:53:54.212528Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"eb6db91b2c71522f switched to configuration voters=(16964418897735406127)"} {"level":"warn","ts":"2026-04-18T17:53:54.229408Z","caller":"auth/store.go:1135","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-18T17:53:54.236538Z","caller":"mvcc/kvstore.go:408","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-18T17:53:54.241041Z","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-04-18T17:53:54.242136Z","caller":"etcdserver/server.go:598","msg":"starting etcd server","local-member-id":"eb6db91b2c71522f","local-server-version":"3.6.4","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-18T17:53:54.242296Z","caller":"etcdserver/server.go:483","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"eb6db91b2c71522f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-18T17:53:54.242463Z","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-04-18T17:53:54.242539Z","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-04-18T17:53:54.242547Z","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-04-18T17:53:54.243239Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"eb6db91b2c71522f switched to configuration voters=(16964418897735406127)"} {"level":"info","ts":"2026-04-18T17:53:54.243434Z","caller":"membership/cluster.go:424","msg":"added member","cluster-id":"f43476f3367c14fb","local-member-id":"eb6db91b2c71522f","added-peer-id":"eb6db91b2c71522f","added-peer-peer-urls":["https://199.19.213.105:2380"],"added-peer-is-learner":false} {"level":"info","ts":"2026-04-18T17:53:54.244614Z","caller":"embed/etcd.go:640","msg":"serving peer traffic","address":"199.19.213.105:2380"} {"level":"info","ts":"2026-04-18T17:53:54.244655Z","caller":"embed/etcd.go:611","msg":"cmux::serve","address":"199.19.213.105:2380"} {"level":"info","ts":"2026-04-18T17:53:54.244556Z","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-04-18T17:53:54.246230Z","caller":"embed/etcd.go:292","msg":"now serving peer/client/metrics","local-member-id":"eb6db91b2c71522f","initial-advertise-peer-urls":["https://199.19.213.105:2380"],"listen-peer-urls":["https://199.19.213.105:2380"],"advertise-client-urls":["https://199.19.213.105:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.105:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-18T17:53:54.246303Z","caller":"embed/etcd.go:890","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-18T17:53:54.912864Z","logger":"raft","caller":"v3@v3.6.0/raft.go:988","msg":"eb6db91b2c71522f is starting a new election at term 1"} {"level":"info","ts":"2026-04-18T17:53:54.912996Z","logger":"raft","caller":"v3@v3.6.0/raft.go:930","msg":"eb6db91b2c71522f became pre-candidate at term 1"} {"level":"info","ts":"2026-04-18T17:53:54.913117Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"eb6db91b2c71522f received MsgPreVoteResp from eb6db91b2c71522f at term 1"} {"level":"info","ts":"2026-04-18T17:53:54.913170Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"eb6db91b2c71522f has received 1 MsgPreVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-04-18T17:53:54.913198Z","logger":"raft","caller":"v3@v3.6.0/raft.go:912","msg":"eb6db91b2c71522f became candidate at term 2"} {"level":"info","ts":"2026-04-18T17:53:54.915170Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"eb6db91b2c71522f received MsgVoteResp from eb6db91b2c71522f at term 2"} {"level":"info","ts":"2026-04-18T17:53:54.915208Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"eb6db91b2c71522f has received 1 MsgVoteResp votes and 0 vote rejections"} {"level":"info","ts":"2026-04-18T17:53:54.915231Z","logger":"raft","caller":"v3@v3.6.0/raft.go:970","msg":"eb6db91b2c71522f became leader at term 2"} {"level":"info","ts":"2026-04-18T17:53:54.915245Z","logger":"raft","caller":"v3@v3.6.0/node.go:370","msg":"raft.node: eb6db91b2c71522f elected leader eb6db91b2c71522f at term 2"} {"level":"info","ts":"2026-04-18T17:53:54.916357Z","caller":"etcdserver/server.go:1804","msg":"published local member to cluster through raft","local-member-id":"eb6db91b2c71522f","local-member-attributes":"{Name:controller-1 ClientURLs:[https://199.19.213.105:2379]}","cluster-id":"f43476f3367c14fb","publish-timeout":"7s"} {"level":"info","ts":"2026-04-18T17:53:54.916403Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-18T17:53:54.916393Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-18T17:53:54.916770Z","caller":"etcdserver/server.go:2404","msg":"setting up initial cluster version using v3 API","cluster-version":"3.6"} {"level":"info","ts":"2026-04-18T17:53:54.916983Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-18T17:53:54.917089Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-18T17:53:54.917894Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-04-18T17:53:54.917909Z","caller":"membership/cluster.go:682","msg":"set initial cluster version","cluster-id":"f43476f3367c14fb","local-member-id":"eb6db91b2c71522f","cluster-version":"3.6"} {"level":"info","ts":"2026-04-18T17:53:54.918371Z","caller":"api/capability.go:76","msg":"enabled capabilities for version","cluster-version":"3.6"} {"level":"info","ts":"2026-04-18T17:53:54.918536Z","caller":"etcdserver/server.go:2424","msg":"cluster version is updated","cluster-version":"3.6"} {"level":"warn","ts":"2026-04-18T17:53:54.921396Z","caller":"v3rpc/grpc.go:52","msg":"etcdserver: failed to register grpc metrics","error":"duplicate metrics collector registration attempted"} {"level":"info","ts":"2026-04-18T17:53:54.921548Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-04-18T17:53:54.922425Z","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-04-18T17:53:54.922772Z","caller":"schema/migration.go:65","msg":"updated storage version","new-storage-version":"3.6.0"} {"level":"info","ts":"2026-04-18T17:53:54.928039Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.105:2379"} {"level":"info","ts":"2026-04-18T17:53:54.928220Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-18T17:53:54.930148Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40068","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:54.930347Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40042","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:54.930441Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40052","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:54.940414Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40100","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:54.965648Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40142","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:54.978169Z","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-04-18T17:53:54.987216Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40174","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:54.995952Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40192","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.010687Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40206","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.026795Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40230","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.037765Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40252","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.051697Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40262","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.058845Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40286","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.065361Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40310","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.071231Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40336","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.077334Z","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-04-18T17:53:55.088030Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40372","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.100308Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40390","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.127518Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40420","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.135952Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40466","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.142461Z","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-04-18T17:53:55.153767Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40494","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.197425Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40502","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.206974Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40526","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.219831Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40542","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.229602Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40562","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.237922Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40584","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.244989Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40606","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.253829Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40614","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.265235Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40628","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.274100Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40644","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.282471Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40650","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.296904Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40656","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.301679Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40692","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.309662Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40702","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.316961Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40728","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.325771Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40738","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.334487Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40752","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.344306Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40770","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.361336Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40788","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.370280Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40806","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.381374Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40822","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.394120Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40840","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.405426Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40856","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.415087Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40874","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.423918Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40892","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.436636Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40896","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.449350Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40920","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.458061Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40936","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.470248Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40958","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.478177Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40970","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.487775Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40990","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.499839Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41014","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.523946Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41016","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.538074Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41022","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.550185Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41036","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.558850Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41046","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.567330Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41052","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.580611Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41062","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.610826Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41082","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.620083Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41090","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.630299Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41114","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:53:55.685229Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:41128","server-name":"","error":"EOF"} {"level":"info","ts":"2026-04-18T17:53:59.158137Z","caller":"traceutil/trace.go:172","msg":"trace[199422786] transaction","detail":"{read_only:false; response_revision:233; number_of_response:1; }","duration":"139.813536ms","start":"2026-04-18T17:53:59.018301Z","end":"2026-04-18T17:53:59.158115Z","steps":["trace[199422786] 'process raft request' (duration: 45.741339ms)","trace[199422786] 'compare' (duration: 93.627602ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:54:00.426038Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"152.044207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:54:00.426143Z","caller":"traceutil/trace.go:172","msg":"trace[2066674350] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:297; }","duration":"152.2212ms","start":"2026-04-18T17:54:00.273899Z","end":"2026-04-18T17:54:00.426120Z","steps":["trace[2066674350] 'agreement among raft nodes before linearized reading' (duration: 25.373342ms)","trace[2066674350] 'range keys from in-memory index tree' (duration: 126.636495ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:54:00.427143Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"126.912329ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:54:00.427419Z","caller":"traceutil/trace.go:172","msg":"trace[218083606] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"153.700836ms","start":"2026-04-18T17:54:00.273698Z","end":"2026-04-18T17:54:00.427399Z","steps":["trace[218083606] 'process raft request' (duration: 153.627735ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:54:00.427445Z","caller":"traceutil/trace.go:172","msg":"trace[1103605579] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"153.784487ms","start":"2026-04-18T17:54:00.273621Z","end":"2026-04-18T17:54:00.427406Z","steps":["trace[1103605579] 'process raft request' (duration: 25.843287ms)","trace[1103605579] 'compare' (duration: 126.738037ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:54:01.118880Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"186.623158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:442"} {"level":"info","ts":"2026-04-18T17:54:01.118973Z","caller":"traceutil/trace.go:172","msg":"trace[2115946016] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:314; }","duration":"186.726169ms","start":"2026-04-18T17:54:00.932226Z","end":"2026-04-18T17:54:01.118952Z","steps":["trace[2115946016] 'agreement among raft nodes before linearized reading' (duration: 17.230031ms)","trace[2115946016] 'range keys from in-memory index tree' (duration: 169.258576ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:54:01.119487Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"169.832942ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:54:01.119792Z","caller":"traceutil/trace.go:172","msg":"trace[1483109208] transaction","detail":"{read_only:false; number_of_response:0; response_revision:316; }","duration":"105.285825ms","start":"2026-04-18T17:54:01.014488Z","end":"2026-04-18T17:54:01.119773Z","steps":["trace[1483109208] 'process raft request' (duration: 105.249535ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:54:01.119865Z","caller":"traceutil/trace.go:172","msg":"trace[1935116191] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"336.37065ms","start":"2026-04-18T17:54:00.783465Z","end":"2026-04-18T17:54:01.119835Z","steps":["trace[1935116191] 'process raft request' (duration: 336.210038ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:54:01.120058Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:54:00.783437Z","time spent":"336.530911ms","remote":"127.0.0.1:40484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":178,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T17:54:01.120112Z","caller":"traceutil/trace.go:172","msg":"trace[1178494009] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"351.818331ms","start":"2026-04-18T17:54:00.767932Z","end":"2026-04-18T17:54:01.119750Z","steps":["trace[1178494009] 'process raft request' (duration: 181.623165ms)","trace[1178494009] 'compare' (duration: 169.69269ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:54:01.120262Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:54:00.767917Z","time spent":"352.262695ms","remote":"127.0.0.1:40436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5952,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:54:01.402488Z","caller":"traceutil/trace.go:172","msg":"trace[940600593] linearizableReadLoop","detail":"{readStateIndex:331; appliedIndex:331; }","duration":"274.775623ms","start":"2026-04-18T17:54:01.127668Z","end":"2026-04-18T17:54:01.402444Z","steps":["trace[940600593] 'read index received' (duration: 274.757853ms)","trace[940600593] 'applied index is now lower than readState.Index' (duration: 16.15µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:54:01.760541Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"632.813758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/statefulset-controller\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:54:01.760650Z","caller":"traceutil/trace.go:172","msg":"trace[1078793635] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/statefulset-controller; range_end:; response_count:0; response_revision:316; }","duration":"632.961469ms","start":"2026-04-18T17:54:01.127663Z","end":"2026-04-18T17:54:01.760625Z","steps":["trace[1078793635] 'agreement among raft nodes before linearized reading' (duration: 274.889154ms)","trace[1078793635] 'range keys from in-memory index tree' (duration: 357.877863ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:54:01.760701Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:54:01.127650Z","time spent":"633.03747ms","remote":"127.0.0.1:40484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":29,"request content":"key:\"/registry/serviceaccounts/kube-system/statefulset-controller\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:54:01.761235Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"358.184326ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:54:01.761755Z","caller":"traceutil/trace.go:172","msg":"trace[639654855] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"635.234223ms","start":"2026-04-18T17:54:01.126498Z","end":"2026-04-18T17:54:01.761732Z","steps":["trace[639654855] 'process raft request' (duration: 276.157717ms)","trace[639654855] 'compare' (duration: 357.769872ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:54:01.761880Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:54:01.126469Z","time spent":"635.334004ms","remote":"127.0.0.1:40578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":427,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:54:01.762217Z","caller":"traceutil/trace.go:172","msg":"trace[1878867763] linearizableReadLoop","detail":"{readStateIndex:332; appliedIndex:331; }","duration":"359.608311ms","start":"2026-04-18T17:54:01.402590Z","end":"2026-04-18T17:54:01.762198Z","steps":["trace[1878867763] 'read index received' (duration: 357.794852ms)","trace[1878867763] 'applied index is now lower than readState.Index' (duration: 1.811799ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:54:01.762359Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"599.189215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-18T17:54:01.762394Z","caller":"traceutil/trace.go:172","msg":"trace[434800016] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:317; }","duration":"599.227115ms","start":"2026-04-18T17:54:01.163157Z","end":"2026-04-18T17:54:01.762384Z","steps":["trace[434800016] 'agreement among raft nodes before linearized reading' (duration: 599.099323ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:54:01.762417Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:54:01.163124Z","time spent":"599.286696ms","remote":"127.0.0.1:40578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"info","ts":"2026-04-18T17:54:01.762872Z","caller":"traceutil/trace.go:172","msg":"trace[2043312655] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"632.266431ms","start":"2026-04-18T17:54:01.130592Z","end":"2026-04-18T17:54:01.762859Z","steps":["trace[2043312655] 'process raft request' (duration: 631.377051ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:54:01.762941Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:54:01.130578Z","time spent":"632.332073ms","remote":"127.0.0.1:40220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":525,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T17:54:01.764006Z","caller":"traceutil/trace.go:172","msg":"trace[374700065] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"630.32625ms","start":"2026-04-18T17:54:01.133653Z","end":"2026-04-18T17:54:01.763979Z","steps":["trace[374700065] 'process raft request' (duration: 628.778694ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:54:01.764318Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:54:01.133628Z","time spent":"630.577113ms","remote":"127.0.0.1:40436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7143,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T17:54:02.308114Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"274.389511ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:54:02.308324Z","caller":"traceutil/trace.go:172","msg":"trace[145373253] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"310.652271ms","start":"2026-04-18T17:54:01.997653Z","end":"2026-04-18T17:54:02.308305Z","steps":["trace[145373253] 'process raft request' (duration: 310.57813ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:54:02.308428Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:54:01.997630Z","time spent":"310.746553ms","remote":"127.0.0.1:40436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7353,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T17:54:02.308223Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"319.642751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/kubeadm:kubeadm-certs\" limit:1 ","response":"range_response_count:1 size:339"} {"level":"info","ts":"2026-04-18T17:54:02.309435Z","caller":"traceutil/trace.go:172","msg":"trace[1831238714] range","detail":"{range_begin:/registry/roles/kube-system/kubeadm:kubeadm-certs; range_end:; response_count:1; response_revision:324; }","duration":"320.133058ms","start":"2026-04-18T17:54:01.988521Z","end":"2026-04-18T17:54:02.308654Z","steps":["trace[1831238714] 'agreement among raft nodes before linearized reading' (duration: 45.099719ms)","trace[1831238714] 'range keys from in-memory index tree' (duration: 274.350031ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:54:02.309590Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:54:01.988496Z","time spent":"321.049457ms","remote":"127.0.0.1:40732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":363,"request content":"key:\"/registry/roles/kube-system/kubeadm:kubeadm-certs\" limit:1 "} {"level":"info","ts":"2026-04-18T17:54:02.308555Z","caller":"traceutil/trace.go:172","msg":"trace[1555613528] transaction","detail":"{read_only:false; response_revision:325; number_of_response:1; }","duration":"340.494871ms","start":"2026-04-18T17:54:01.967963Z","end":"2026-04-18T17:54:02.308458Z","steps":["trace[1555613528] 'process raft request' (duration: 65.689436ms)","trace[1555613528] 'compare' (duration: 274.2496ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:54:02.310143Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:54:01.967947Z","time spent":"342.10746ms","remote":"127.0.0.1:40484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":201,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T17:54:02.558484Z","caller":"traceutil/trace.go:172","msg":"trace[246684267] linearizableReadLoop","detail":"{readStateIndex:344; appliedIndex:344; }","duration":"205.45763ms","start":"2026-04-18T17:54:02.352975Z","end":"2026-04-18T17:54:02.558433Z","steps":["trace[246684267] 'read index received' (duration: 205.43881ms)","trace[246684267] 'applied index is now lower than readState.Index' (duration: 16.34µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:54:02.878617Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"319.682671ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"warn","ts":"2026-04-18T17:54:02.878614Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"555.78153ms","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-04-18T17:54:02.878768Z","caller":"traceutil/trace.go:172","msg":"trace[383201027] transaction","detail":"{read_only:false; response_revision:327; number_of_response:1; }","duration":"555.737939ms","start":"2026-04-18T17:54:02.323006Z","end":"2026-04-18T17:54:02.878744Z","steps":["trace[383201027] 'process raft request' (duration: 235.821305ms)","trace[383201027] 'compare' (duration: 319.52119ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:54:02.878775Z","caller":"traceutil/trace.go:172","msg":"trace[1343520989] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:326; }","duration":"555.969412ms","start":"2026-04-18T17:54:02.322771Z","end":"2026-04-18T17:54:02.878741Z","steps":["trace[1343520989] 'agreement among raft nodes before linearized reading' (duration: 235.881696ms)","trace[1343520989] 'range keys from in-memory index tree' (duration: 319.706062ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:54:02.878832Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:54:02.322761Z","time spent":"556.059563ms","remote":"127.0.0.1:40244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":1,"response size":375,"request content":"key:\"/registry/namespaces/kube-system\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:54:02.878864Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:54:02.322991Z","time spent":"555.84205ms","remote":"127.0.0.1:40436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4941,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:54:02.973752Z","caller":"traceutil/trace.go:172","msg":"trace[1365636470] linearizableReadLoop","detail":"{readStateIndex:345; appliedIndex:345; }","duration":"414.973124ms","start":"2026-04-18T17:54:02.558724Z","end":"2026-04-18T17:54:02.973697Z","steps":["trace[1365636470] 'read index received' (duration: 414.954234ms)","trace[1365636470] 'applied index is now lower than readState.Index' (duration: 16.18µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:54:02.974092Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"619.264151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/kubeadm:kubeadm-certs\" limit:1 ","response":"range_response_count:1 size:483"} {"level":"info","ts":"2026-04-18T17:54:02.974131Z","caller":"traceutil/trace.go:172","msg":"trace[66467379] range","detail":"{range_begin:/registry/rolebindings/kube-system/kubeadm:kubeadm-certs; range_end:; response_count:1; response_revision:327; }","duration":"619.333942ms","start":"2026-04-18T17:54:02.354784Z","end":"2026-04-18T17:54:02.974118Z","steps":["trace[66467379] 'agreement among raft nodes before linearized reading' (duration: 619.081069ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:54:02.974170Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:54:02.354753Z","time spent":"619.407683ms","remote":"127.0.0.1:40746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":507,"request content":"key:\"/registry/rolebindings/kube-system/kubeadm:kubeadm-certs\" limit:1 "} {"level":"info","ts":"2026-04-18T17:54:02.974367Z","caller":"traceutil/trace.go:172","msg":"trace[2028571124] transaction","detail":"{read_only:false; response_revision:328; number_of_response:1; }","duration":"540.588102ms","start":"2026-04-18T17:54:02.433746Z","end":"2026-04-18T17:54:02.974334Z","steps":["trace[2028571124] 'process raft request' (duration: 540.257018ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:54:02.974571Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"617.575232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" limit:1 ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-04-18T17:54:02.974606Z","caller":"traceutil/trace.go:172","msg":"trace[1812824105] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:328; }","duration":"617.610853ms","start":"2026-04-18T17:54:02.356987Z","end":"2026-04-18T17:54:02.974597Z","steps":["trace[1812824105] 'agreement among raft nodes before linearized reading' (duration: 617.513252ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:54:02.974604Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:54:02.433684Z","time spent":"540.801335ms","remote":"127.0.0.1:40578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T17:54:02.974632Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:54:02.356971Z","time spent":"617.654393ms","remote":"127.0.0.1:40484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":1,"response size":240,"request content":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" limit:1 "} {"level":"info","ts":"2026-04-18T17:54:02.993738Z","caller":"traceutil/trace.go:172","msg":"trace[493776088] transaction","detail":"{read_only:false; response_revision:330; number_of_response:1; }","duration":"108.170215ms","start":"2026-04-18T17:54:02.885544Z","end":"2026-04-18T17:54:02.993715Z","steps":["trace[493776088] 'process raft request' (duration: 108.043804ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:54:02.993903Z","caller":"traceutil/trace.go:172","msg":"trace[1511114239] transaction","detail":"{read_only:false; response_revision:329; number_of_response:1; }","duration":"360.670545ms","start":"2026-04-18T17:54:02.633208Z","end":"2026-04-18T17:54:02.993878Z","steps":["trace[1511114239] 'process raft request' (duration: 348.072996ms)","trace[1511114239] 'compare' (duration: 11.927821ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:54:02.994066Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:54:02.633123Z","time spent":"360.842757ms","remote":"127.0.0.1:40578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":468,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T17:54:07.024728Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"306.660186ms","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-04-18T17:54:07.024821Z","caller":"traceutil/trace.go:172","msg":"trace[1374654383] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:402; }","duration":"306.767787ms","start":"2026-04-18T17:54:06.718036Z","end":"2026-04-18T17:54:07.024804Z","steps":["trace[1374654383] 'range keys from in-memory index tree' (duration: 306.602526ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:54:07.025033Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"336.415792ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:54:07.025370Z","caller":"traceutil/trace.go:172","msg":"trace[1292937684] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"345.147798ms","start":"2026-04-18T17:54:06.680159Z","end":"2026-04-18T17:54:07.025307Z","steps":["trace[1292937684] 'compare' (duration: 336.099689ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:54:07.025616Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:54:06.680139Z","time spent":"345.36671ms","remote":"127.0.0.1:40168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":858,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T17:54:07.025919Z","caller":"traceutil/trace.go:172","msg":"trace[1963036147] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"344.792904ms","start":"2026-04-18T17:54:06.681110Z","end":"2026-04-18T17:54:07.025903Z","steps":["trace[1963036147] 'process raft request' (duration: 344.009786ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:54:07.026023Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:54:06.681094Z","time spent":"344.876415ms","remote":"127.0.0.1:40436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4342,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:54:07.026131Z","caller":"traceutil/trace.go:172","msg":"trace[610322381] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"343.184186ms","start":"2026-04-18T17:54:06.682833Z","end":"2026-04-18T17:54:07.026017Z","steps":["trace[610322381] 'process raft request' (duration: 342.948373ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:54:07.026575Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:54:06.682805Z","time spent":"343.587832ms","remote":"127.0.0.1:40168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T17:54:07.026631Z","caller":"traceutil/trace.go:172","msg":"trace[1793622308] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"335.174329ms","start":"2026-04-18T17:54:06.691439Z","end":"2026-04-18T17:54:07.026613Z","steps":["trace[1793622308] 'process raft request' (duration: 334.42571ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:54:07.026705Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:54:06.691415Z","time spent":"335.25694ms","remote":"127.0.0.1:41002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4086,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T17:54:12.380879Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5922125352956340228,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-18T17:54:12.822857Z","caller":"traceutil/trace.go:172","msg":"trace[360629134] linearizableReadLoop","detail":"{readStateIndex:449; appliedIndex:449; }","duration":"942.918877ms","start":"2026-04-18T17:54:11.879894Z","end":"2026-04-18T17:54:12.822813Z","steps":["trace[360629134] 'read index received' (duration: 942.899956ms)","trace[360629134] 'applied index is now lower than readState.Index' (duration: 16.101µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:54:12.823070Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"943.135349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-18T17:54:12.823139Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"622.868393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:54:12.823169Z","caller":"traceutil/trace.go:172","msg":"trace[940714689] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:429; }","duration":"943.2629ms","start":"2026-04-18T17:54:11.879887Z","end":"2026-04-18T17:54:12.823150Z","steps":["trace[940714689] 'agreement among raft nodes before linearized reading' (duration: 943.004887ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:54:12.823207Z","caller":"traceutil/trace.go:172","msg":"trace[183912617] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:430; }","duration":"622.941904ms","start":"2026-04-18T17:54:12.200252Z","end":"2026-04-18T17:54:12.823194Z","steps":["trace[183912617] 'agreement among raft nodes before linearized reading' (duration: 622.828392ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:54:12.823230Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:54:11.879871Z","time spent":"943.350451ms","remote":"127.0.0.1:40578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:54:12.823240Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:54:12.200230Z","time spent":"623.002955ms","remote":"127.0.0.1:40032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-18T17:54:12.823302Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"107.549632ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:54:12.823354Z","caller":"traceutil/trace.go:172","msg":"trace[490916552] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:430; }","duration":"107.646053ms","start":"2026-04-18T17:54:12.715697Z","end":"2026-04-18T17:54:12.823343Z","steps":["trace[490916552] 'agreement among raft nodes before linearized reading' (duration: 107.499842ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:54:12.823933Z","caller":"traceutil/trace.go:172","msg":"trace[13863463] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"947.650247ms","start":"2026-04-18T17:54:11.875504Z","end":"2026-04-18T17:54:12.823154Z","steps":["trace[13863463] 'process raft request' (duration: 947.335084ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:54:12.824089Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:54:11.875470Z","time spent":"948.533466ms","remote":"127.0.0.1:40578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":427,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:54:12.983772Z","caller":"traceutil/trace.go:172","msg":"trace[1742869702] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"153.701072ms","start":"2026-04-18T17:54:12.829998Z","end":"2026-04-18T17:54:12.983699Z","steps":["trace[1742869702] 'process raft request' (duration: 147.044711ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:54:15.240672Z","caller":"traceutil/trace.go:172","msg":"trace[1474797833] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"184.396782ms","start":"2026-04-18T17:54:15.056219Z","end":"2026-04-18T17:54:15.240616Z","steps":["trace[1474797833] 'process raft request' (duration: 91.888678ms)","trace[1474797833] 'compare' (duration: 92.272981ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:54:15.240914Z","caller":"traceutil/trace.go:172","msg":"trace[333735501] transaction","detail":"{read_only:false; response_revision:437; number_of_response:1; }","duration":"137.206075ms","start":"2026-04-18T17:54:15.103682Z","end":"2026-04-18T17:54:15.240888Z","steps":["trace[333735501] 'process raft request' (duration: 136.849521ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:54:20.126747Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.069153986s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" limit:1 ","response":"range_response_count:1 size:422"} {"level":"warn","ts":"2026-04-18T17:54:20.126813Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.220067962s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:442"} {"level":"warn","ts":"2026-04-18T17:54:20.126813Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.928025138s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:54:20.126892Z","caller":"traceutil/trace.go:172","msg":"trace[1456330793] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:443; }","duration":"1.220165613s","start":"2026-04-18T17:54:18.906710Z","end":"2026-04-18T17:54:20.126876Z","steps":["trace[1456330793] 'range keys from in-memory index tree' (duration: 1.21986018s)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:54:20.126907Z","caller":"traceutil/trace.go:172","msg":"trace[359666603] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:443; }","duration":"1.928133259s","start":"2026-04-18T17:54:18.198757Z","end":"2026-04-18T17:54:20.126890Z","steps":["trace[359666603] 'range keys from in-memory index tree' (duration: 1.927931347s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:54:20.126935Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:54:18.906662Z","time spent":"1.220263054s","remote":"127.0.0.1:40578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":466,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:54:20.126931Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.411173685s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T17:54:20.126949Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.071231434s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-18T17:54:20.126953Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:54:18.198729Z","time spent":"1.92820909s","remote":"127.0.0.1:40032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-18T17:54:20.126985Z","caller":"traceutil/trace.go:172","msg":"trace[1819393223] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:443; }","duration":"1.411231796s","start":"2026-04-18T17:54:18.715738Z","end":"2026-04-18T17:54:20.126969Z","steps":["trace[1819393223] 'range keys from in-memory index tree' (duration: 1.411128145s)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:54:20.127016Z","caller":"traceutil/trace.go:172","msg":"trace[782222666] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:443; }","duration":"1.071267054s","start":"2026-04-18T17:54:19.055709Z","end":"2026-04-18T17:54:20.126976Z","steps":["trace[782222666] 'range keys from in-memory index tree' (duration: 1.071136152s)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:54:20.126842Z","caller":"traceutil/trace.go:172","msg":"trace[138114507] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:443; }","duration":"2.069268237s","start":"2026-04-18T17:54:18.057553Z","end":"2026-04-18T17:54:20.126821Z","steps":["trace[138114507] 'range keys from in-memory index tree' (duration: 2.068974285s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:54:20.127140Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:54:18.057539Z","time spent":"2.06958018s","remote":"127.0.0.1:40380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":446,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" limit:1 "} {"level":"info","ts":"2026-04-18T17:54:20.127152Z","caller":"traceutil/trace.go:172","msg":"trace[1756240597] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"872.624975ms","start":"2026-04-18T17:54:19.254513Z","end":"2026-04-18T17:54:20.127138Z","steps":["trace[1756240597] 'process raft request' (duration: 832.453527ms)","trace[1756240597] 'compare' (duration: 39.667342ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:54:20.127077Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:54:19.055692Z","time spent":"1.071369705s","remote":"127.0.0.1:40578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:54:20.127254Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:54:19.254487Z","time spent":"872.691585ms","remote":"127.0.0.1:40578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:54:20.226799Z","caller":"traceutil/trace.go:172","msg":"trace[1563299019] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"971.62828ms","start":"2026-04-18T17:54:19.255138Z","end":"2026-04-18T17:54:20.226766Z","steps":["trace[1563299019] 'process raft request' (duration: 971.486048ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:54:20.227007Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:54:19.255120Z","time spent":"971.785461ms","remote":"127.0.0.1:40578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":467,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T17:54:20.261380Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"131.559371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-18T17:54:20.261446Z","caller":"traceutil/trace.go:172","msg":"trace[2145619571] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:445; }","duration":"131.632521ms","start":"2026-04-18T17:54:20.129796Z","end":"2026-04-18T17:54:20.261428Z","steps":["trace[2145619571] 'agreement among raft nodes before linearized reading' (duration: 116.42599ms)","trace[2145619571] 'range keys from in-memory index tree' (duration: 15.04569ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:54:20.261553Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"132.060775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:54:20.261807Z","caller":"traceutil/trace.go:172","msg":"trace[172477010] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:445; }","duration":"132.328118ms","start":"2026-04-18T17:54:20.129468Z","end":"2026-04-18T17:54:20.261796Z","steps":["trace[172477010] 'agreement among raft nodes before linearized reading' (duration: 116.773463ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:54:20.261663Z","caller":"traceutil/trace.go:172","msg":"trace[1372176795] transaction","detail":"{read_only:false; response_revision:446; number_of_response:1; }","duration":"128.821041ms","start":"2026-04-18T17:54:20.132796Z","end":"2026-04-18T17:54:20.261617Z","steps":["trace[1372176795] 'process raft request' (duration: 113.482279ms)","trace[1372176795] 'compare' (duration: 14.992259ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:54:20.261733Z","caller":"traceutil/trace.go:172","msg":"trace[948422854] transaction","detail":"{read_only:false; response_revision:447; number_of_response:1; }","duration":"127.539907ms","start":"2026-04-18T17:54:20.134174Z","end":"2026-04-18T17:54:20.261714Z","steps":["trace[948422854] 'process raft request' (duration: 127.322055ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:54:39.413657Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"eb6db91b2c71522f switched to configuration voters=(16964418897735406127) learners=(15957421377254794832)"} {"level":"info","ts":"2026-04-18T17:54:39.413999Z","caller":"membership/cluster.go:424","msg":"added member","cluster-id":"f43476f3367c14fb","local-member-id":"eb6db91b2c71522f","added-peer-id":"dd742632527f2650","added-peer-peer-urls":["https://199.19.213.100:2380"],"added-peer-is-learner":true} {"level":"info","ts":"2026-04-18T17:54:39.414087Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"dd742632527f2650"} {"level":"info","ts":"2026-04-18T17:54:39.414129Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"eb6db91b2c71522f","remote-peer-id":"dd742632527f2650"} {"level":"info","ts":"2026-04-18T17:54:39.414257Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"dd742632527f2650"} {"level":"info","ts":"2026-04-18T17:54:39.414294Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"eb6db91b2c71522f","remote-peer-id":"dd742632527f2650","remote-peer-urls":["https://199.19.213.100:2380"]} {"level":"info","ts":"2026-04-18T17:54:39.414280Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"eb6db91b2c71522f","remote-peer-id":"dd742632527f2650"} {"level":"info","ts":"2026-04-18T17:54:39.414335Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"eb6db91b2c71522f","remote-peer-id":"dd742632527f2650"} {"level":"info","ts":"2026-04-18T17:54:39.414337Z","caller":"etcdserver/server.go:1752","msg":"applied a configuration change through raft","local-member-id":"eb6db91b2c71522f","raft-conf-change":"ConfChangeAddLearnerNode","raft-conf-change-node-id":"dd742632527f2650"} {"level":"info","ts":"2026-04-18T17:54:39.414355Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"eb6db91b2c71522f","remote-peer-id":"dd742632527f2650"} {"level":"info","ts":"2026-04-18T17:54:39.414405Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"eb6db91b2c71522f","remote-peer-id":"dd742632527f2650"} {"level":"error","ts":"2026-04-18T17:54:39.474896Z","caller":"etcdserver/server.go:1585","msg":"rejecting promote learner: learner is not ready","learner-ready-percent":0,"ready-percent-threshold":0.9,"stacktrace":"go.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).isLearnerReady\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1585\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).mayPromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1526\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).promoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1498\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).PromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1450\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.(*ClusterServer).MemberPromote\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/member.go:101\ngo.etcd.io/etcd/api/v3/etcdserverpb._Cluster_MemberPromote_Handler.func1\n\tgo.etcd.io/etcd/api/v3@v3.6.4/etcdserverpb/rpc.pb.go:7432\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.(*ServerMetrics).UnaryServerInterceptor.UnaryServerInterceptor.func12\n\tgithub.com/grpc-ecosystem/go-grpc-middleware/v2@v2.1.0/interceptors/server.go:22\ngoogle.golang.org/grpc.getChainUnaryHandler.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1217\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.newUnaryInterceptor.func5\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/interceptor.go:74\ngoogle.golang.org/grpc.getChainUnaryHandler.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1217\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.newLogUnaryInterceptor.func4\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/interceptor.go:81\ngoogle.golang.org/grpc.NewServer.chainUnaryServerInterceptors.chainUnaryInterceptors.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1208\ngo.etcd.io/etcd/api/v3/etcdserverpb._Cluster_MemberPromote_Handler\n\tgo.etcd.io/etcd/api/v3@v3.6.4/etcdserverpb/rpc.pb.go:7434\ngoogle.golang.org/grpc.(*Server).processUnaryRPC\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1405\ngoogle.golang.org/grpc.(*Server).handleStream\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1815\ngoogle.golang.org/grpc.(*Server).serveStreams.func2.1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1035"} {"level":"error","ts":"2026-04-18T17:54:39.971034Z","caller":"etcdserver/server.go:1585","msg":"rejecting promote learner: learner is not ready","learner-ready-percent":0,"ready-percent-threshold":0.9,"stacktrace":"go.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).isLearnerReady\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1585\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).mayPromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1526\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).promoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1498\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).PromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1450\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.(*ClusterServer).MemberPromote\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/member.go:101\ngo.etcd.io/etcd/api/v3/etcdserverpb._Cluster_MemberPromote_Handler.func1\n\tgo.etcd.io/etcd/api/v3@v3.6.4/etcdserverpb/rpc.pb.go:7432\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.(*ServerMetrics).UnaryServerInterceptor.UnaryServerInterceptor.func12\n\tgithub.com/grpc-ecosystem/go-grpc-middleware/v2@v2.1.0/interceptors/server.go:22\ngoogle.golang.org/grpc.getChainUnaryHandler.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1217\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.newUnaryInterceptor.func5\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/interceptor.go:74\ngoogle.golang.org/grpc.getChainUnaryHandler.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1217\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.newLogUnaryInterceptor.func4\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/interceptor.go:81\ngoogle.golang.org/grpc.NewServer.chainUnaryServerInterceptors.chainUnaryInterceptors.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1208\ngo.etcd.io/etcd/api/v3/etcdserverpb._Cluster_MemberPromote_Handler\n\tgo.etcd.io/etcd/api/v3@v3.6.4/etcdserverpb/rpc.pb.go:7434\ngoogle.golang.org/grpc.(*Server).processUnaryRPC\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1405\ngoogle.golang.org/grpc.(*Server).handleStream\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1815\ngoogle.golang.org/grpc.(*Server).serveStreams.func2.1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1035"} {"level":"error","ts":"2026-04-18T17:54:40.475471Z","caller":"etcdserver/server.go:1585","msg":"rejecting promote learner: learner is not ready","learner-ready-percent":0,"ready-percent-threshold":0.9,"stacktrace":"go.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).isLearnerReady\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1585\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).mayPromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1526\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).promoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1498\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).PromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1450\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.(*ClusterServer).MemberPromote\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/member.go:101\ngo.etcd.io/etcd/api/v3/etcdserverpb._Cluster_MemberPromote_Handler.func1\n\tgo.etcd.io/etcd/api/v3@v3.6.4/etcdserverpb/rpc.pb.go:7432\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.(*ServerMetrics).UnaryServerInterceptor.UnaryServerInterceptor.func12\n\tgithub.com/grpc-ecosystem/go-grpc-middleware/v2@v2.1.0/interceptors/server.go:22\ngoogle.golang.org/grpc.getChainUnaryHandler.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1217\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.newUnaryInterceptor.func5\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/interceptor.go:74\ngoogle.golang.org/grpc.getChainUnaryHandler.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1217\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.newLogUnaryInterceptor.func4\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/interceptor.go:81\ngoogle.golang.org/grpc.NewServer.chainUnaryServerInterceptors.chainUnaryInterceptors.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1208\ngo.etcd.io/etcd/api/v3/etcdserverpb._Cluster_MemberPromote_Handler\n\tgo.etcd.io/etcd/api/v3@v3.6.4/etcdserverpb/rpc.pb.go:7434\ngoogle.golang.org/grpc.(*Server).processUnaryRPC\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1405\ngoogle.golang.org/grpc.(*Server).handleStream\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1815\ngoogle.golang.org/grpc.(*Server).serveStreams.func2.1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1035"} {"level":"error","ts":"2026-04-18T17:54:40.973642Z","caller":"etcdserver/server.go:1585","msg":"rejecting promote learner: learner is not ready","learner-ready-percent":0,"ready-percent-threshold":0.9,"stacktrace":"go.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).isLearnerReady\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1585\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).mayPromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1526\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).promoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1498\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).PromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1450\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.(*ClusterServer).MemberPromote\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/member.go:101\ngo.etcd.io/etcd/api/v3/etcdserverpb._Cluster_MemberPromote_Handler.func1\n\tgo.etcd.io/etcd/api/v3@v3.6.4/etcdserverpb/rpc.pb.go:7432\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.(*ServerMetrics).UnaryServerInterceptor.UnaryServerInterceptor.func12\n\tgithub.com/grpc-ecosystem/go-grpc-middleware/v2@v2.1.0/interceptors/server.go:22\ngoogle.golang.org/grpc.getChainUnaryHandler.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1217\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.newUnaryInterceptor.func5\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/interceptor.go:74\ngoogle.golang.org/grpc.getChainUnaryHandler.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1217\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.newLogUnaryInterceptor.func4\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/interceptor.go:81\ngoogle.golang.org/grpc.NewServer.chainUnaryServerInterceptors.chainUnaryInterceptors.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1208\ngo.etcd.io/etcd/api/v3/etcdserverpb._Cluster_MemberPromote_Handler\n\tgo.etcd.io/etcd/api/v3@v3.6.4/etcdserverpb/rpc.pb.go:7434\ngoogle.golang.org/grpc.(*Server).processUnaryRPC\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1405\ngoogle.golang.org/grpc.(*Server).handleStream\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1815\ngoogle.golang.org/grpc.(*Server).serveStreams.func2.1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1035"} {"level":"error","ts":"2026-04-18T17:54:41.476141Z","caller":"etcdserver/server.go:1585","msg":"rejecting promote learner: learner is not ready","learner-ready-percent":0,"ready-percent-threshold":0.9,"stacktrace":"go.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).isLearnerReady\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1585\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).mayPromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1526\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).promoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1498\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).PromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1450\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.(*ClusterServer).MemberPromote\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/member.go:101\ngo.etcd.io/etcd/api/v3/etcdserverpb._Cluster_MemberPromote_Handler.func1\n\tgo.etcd.io/etcd/api/v3@v3.6.4/etcdserverpb/rpc.pb.go:7432\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.(*ServerMetrics).UnaryServerInterceptor.UnaryServerInterceptor.func12\n\tgithub.com/grpc-ecosystem/go-grpc-middleware/v2@v2.1.0/interceptors/server.go:22\ngoogle.golang.org/grpc.getChainUnaryHandler.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1217\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.newUnaryInterceptor.func5\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/interceptor.go:74\ngoogle.golang.org/grpc.getChainUnaryHandler.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1217\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.newLogUnaryInterceptor.func4\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/interceptor.go:81\ngoogle.golang.org/grpc.NewServer.chainUnaryServerInterceptors.chainUnaryInterceptors.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1208\ngo.etcd.io/etcd/api/v3/etcdserverpb._Cluster_MemberPromote_Handler\n\tgo.etcd.io/etcd/api/v3@v3.6.4/etcdserverpb/rpc.pb.go:7434\ngoogle.golang.org/grpc.(*Server).processUnaryRPC\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1405\ngoogle.golang.org/grpc.(*Server).handleStream\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1815\ngoogle.golang.org/grpc.(*Server).serveStreams.func2.1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1035"} {"level":"error","ts":"2026-04-18T17:54:41.975803Z","caller":"etcdserver/server.go:1585","msg":"rejecting promote learner: learner is not ready","learner-ready-percent":0,"ready-percent-threshold":0.9,"stacktrace":"go.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).isLearnerReady\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1585\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).mayPromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1526\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).promoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1498\ngo.etcd.io/etcd/server/v3/etcdserver.(*EtcdServer).PromoteMember\n\tgo.etcd.io/etcd/server/v3/etcdserver/server.go:1450\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.(*ClusterServer).MemberPromote\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/member.go:101\ngo.etcd.io/etcd/api/v3/etcdserverpb._Cluster_MemberPromote_Handler.func1\n\tgo.etcd.io/etcd/api/v3@v3.6.4/etcdserverpb/rpc.pb.go:7432\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.(*ServerMetrics).UnaryServerInterceptor.UnaryServerInterceptor.func12\n\tgithub.com/grpc-ecosystem/go-grpc-middleware/v2@v2.1.0/interceptors/server.go:22\ngoogle.golang.org/grpc.getChainUnaryHandler.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1217\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.newUnaryInterceptor.func5\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/interceptor.go:74\ngoogle.golang.org/grpc.getChainUnaryHandler.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1217\ngo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc.Server.newLogUnaryInterceptor.func4\n\tgo.etcd.io/etcd/server/v3/etcdserver/api/v3rpc/interceptor.go:81\ngoogle.golang.org/grpc.NewServer.chainUnaryServerInterceptors.chainUnaryInterceptors.func1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1208\ngo.etcd.io/etcd/api/v3/etcdserverpb._Cluster_MemberPromote_Handler\n\tgo.etcd.io/etcd/api/v3@v3.6.4/etcdserverpb/rpc.pb.go:7434\ngoogle.golang.org/grpc.(*Server).processUnaryRPC\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1405\ngoogle.golang.org/grpc.(*Server).handleStream\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1815\ngoogle.golang.org/grpc.(*Server).serveStreams.func2.1\n\tgoogle.golang.org/grpc@v1.71.1/server.go:1035"} {"level":"info","ts":"2026-04-18T17:54:42.135222Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"dd742632527f2650"} {"level":"info","ts":"2026-04-18T17:54:42.135316Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"eb6db91b2c71522f","remote-peer-id":"dd742632527f2650"} {"level":"info","ts":"2026-04-18T17:54:42.135307Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"eb6db91b2c71522f","remote-peer-id":"dd742632527f2650"} {"level":"info","ts":"2026-04-18T17:54:42.143009Z","caller":"etcdserver/server.go:1838","msg":"sending merged snapshot","from":"eb6db91b2c71522f","to":"dd742632527f2650","bytes":794635,"size":"795 kB"} {"level":"info","ts":"2026-04-18T17:54:42.143213Z","caller":"rafthttp/snapshot_sender.go:82","msg":"sending database snapshot","snapshot-index":522,"remote-peer-id":"dd742632527f2650","bytes":794635,"size":"795 kB"} {"level":"info","ts":"2026-04-18T17:54:42.144483Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"eb6db91b2c71522f","to":"dd742632527f2650","stream-type":"stream Message"} {"level":"info","ts":"2026-04-18T17:54:42.144540Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"eb6db91b2c71522f","remote-peer-id":"dd742632527f2650"} {"level":"info","ts":"2026-04-18T17:54:42.145845Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"eb6db91b2c71522f","to":"dd742632527f2650","stream-type":"stream MsgApp v2"} {"level":"info","ts":"2026-04-18T17:54:42.145888Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"eb6db91b2c71522f","remote-peer-id":"dd742632527f2650"} {"level":"info","ts":"2026-04-18T17:54:42.148640Z","caller":"etcdserver/snapshot_merge.go:64","msg":"sent database snapshot to writer","bytes":786432,"size":"786 kB"} {"level":"info","ts":"2026-04-18T17:54:42.154506Z","caller":"rafthttp/snapshot_sender.go:131","msg":"sent database snapshot","snapshot-index":522,"remote-peer-id":"dd742632527f2650","bytes":794635,"size":"795 kB"} {"level":"warn","ts":"2026-04-18T17:54:42.168865Z","caller":"rafthttp/stream.go:420","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"eb6db91b2c71522f","remote-peer-id":"dd742632527f2650","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:54:42.169166Z","caller":"rafthttp/stream.go:420","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"eb6db91b2c71522f","remote-peer-id":"dd742632527f2650","error":"EOF"} {"level":"info","ts":"2026-04-18T17:54:42.180595Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"eb6db91b2c71522f","to":"dd742632527f2650","stream-type":"stream Message"} {"level":"warn","ts":"2026-04-18T17:54:42.180667Z","caller":"rafthttp/stream.go:264","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"eb6db91b2c71522f","remote-peer-id":"dd742632527f2650"} {"level":"info","ts":"2026-04-18T17:54:42.180690Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"eb6db91b2c71522f","remote-peer-id":"dd742632527f2650"} {"level":"info","ts":"2026-04-18T17:54:42.183744Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"eb6db91b2c71522f","to":"dd742632527f2650","stream-type":"stream MsgApp v2"} {"level":"warn","ts":"2026-04-18T17:54:42.183810Z","caller":"rafthttp/stream.go:264","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"eb6db91b2c71522f","remote-peer-id":"dd742632527f2650"} {"level":"info","ts":"2026-04-18T17:54:42.183827Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"eb6db91b2c71522f","remote-peer-id":"dd742632527f2650"} {"level":"info","ts":"2026-04-18T17:54:42.239996Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"eb6db91b2c71522f","remote-peer-id":"dd742632527f2650"} {"level":"info","ts":"2026-04-18T17:54:42.242061Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"eb6db91b2c71522f","remote-peer-id":"dd742632527f2650"} {"level":"info","ts":"2026-04-18T17:54:42.483051Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"eb6db91b2c71522f switched to configuration voters=(15957421377254794832 16964418897735406127)"} {"level":"info","ts":"2026-04-18T17:54:42.483290Z","caller":"membership/cluster.go:550","msg":"promote member","cluster-id":"f43476f3367c14fb","local-member-id":"eb6db91b2c71522f","promoted-member-id":"dd742632527f2650"} {"level":"info","ts":"2026-04-18T17:54:42.483409Z","caller":"etcdserver/server.go:1752","msg":"applied a configuration change through raft","local-member-id":"eb6db91b2c71522f","raft-conf-change":"ConfChangeAddNode","raft-conf-change-node-id":"dd742632527f2650"} {"level":"info","ts":"2026-04-18T17:54:46.505084Z","caller":"traceutil/trace.go:172","msg":"trace[1573213555] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"137.606839ms","start":"2026-04-18T17:54:46.367457Z","end":"2026-04-18T17:54:46.505064Z","steps":["trace[1573213555] 'process raft request' (duration: 137.459978ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:54:46.618062Z","caller":"traceutil/trace.go:172","msg":"trace[811788645] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"107.046935ms","start":"2026-04-18T17:54:46.510989Z","end":"2026-04-18T17:54:46.618036Z","steps":["trace[811788645] 'process raft request' (duration: 106.912144ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:54:46.623885Z","caller":"traceutil/trace.go:172","msg":"trace[836665852] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"112.809955ms","start":"2026-04-18T17:54:46.511050Z","end":"2026-04-18T17:54:46.623860Z","steps":["trace[836665852] 'process raft request' (duration: 112.648643ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:54:59.121392Z","caller":"etcdserver/raft.go:387","msg":"leader failed to send out heartbeat on time; took too long, leader is overloaded likely from slow disk","to":"dd742632527f2650","heartbeat-interval":"100ms","expected-duration":"200ms","exceeded-duration":"8.503893ms"} {"level":"warn","ts":"2026-04-18T17:54:59.323669Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"124.819738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:54:59.323766Z","caller":"traceutil/trace.go:172","msg":"trace[746479893] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:541; }","duration":"124.93238ms","start":"2026-04-18T17:54:59.198812Z","end":"2026-04-18T17:54:59.323744Z","steps":["trace[746479893] 'agreement among raft nodes before linearized reading' (duration: 83.196199ms)","trace[746479893] 'range keys from in-memory index tree' (duration: 41.577899ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:54:59.324297Z","caller":"traceutil/trace.go:172","msg":"trace[218050296] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"171.034726ms","start":"2026-04-18T17:54:59.153233Z","end":"2026-04-18T17:54:59.324268Z","steps":["trace[218050296] 'process raft request' (duration: 126.957971ms)","trace[218050296] 'compare' (duration: 43.813791ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:55:00.177987Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"219.079158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:55:00.178107Z","caller":"traceutil/trace.go:172","msg":"trace[278962388] range","detail":"{range_begin:/registry/limitranges; range_end:; response_count:0; response_revision:543; }","duration":"219.22324ms","start":"2026-04-18T17:54:59.958856Z","end":"2026-04-18T17:55:00.178080Z","steps":["trace[278962388] 'agreement among raft nodes before linearized reading' (duration: 89.158659ms)","trace[278962388] 'range keys from in-memory index tree' (duration: 129.864739ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:55:00.178364Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"161.892191ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:55:00.178553Z","caller":"traceutil/trace.go:172","msg":"trace[1654606859] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"220.626294ms","start":"2026-04-18T17:54:59.957901Z","end":"2026-04-18T17:55:00.178528Z","steps":["trace[1654606859] 'process raft request' (duration: 58.47264ms)","trace[1654606859] 'compare' (duration: 161.74474ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:55:00.411055Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"109.950468ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:55:00.411191Z","caller":"traceutil/trace.go:172","msg":"trace[1485923044] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"223.924987ms","start":"2026-04-18T17:55:00.187253Z","end":"2026-04-18T17:55:00.411178Z","steps":["trace[1485923044] 'process raft request' (duration: 113.788826ms)","trace[1485923044] 'compare' (duration: 109.840957ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:55:00.411626Z","caller":"traceutil/trace.go:172","msg":"trace[73179540] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"154.024283ms","start":"2026-04-18T17:55:00.257593Z","end":"2026-04-18T17:55:00.411617Z","steps":["trace[73179540] 'process raft request' (duration: 153.987273ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:55:00.411836Z","caller":"traceutil/trace.go:172","msg":"trace[664767700] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"155.527909ms","start":"2026-04-18T17:55:00.256286Z","end":"2026-04-18T17:55:00.411814Z","steps":["trace[664767700] 'process raft request' (duration: 155.256656ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:55:03.798935Z","caller":"etcdserver/server.go:2246","msg":"skip compaction since there is an inflight snapshot"} {"level":"info","ts":"2026-04-18T17:55:04.611922Z","caller":"traceutil/trace.go:172","msg":"trace[225504220] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"154.076206ms","start":"2026-04-18T17:55:04.457819Z","end":"2026-04-18T17:55:04.611895Z","steps":["trace[225504220] 'process raft request' (duration: 153.885534ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:07.476167Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"175.736859ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-18T17:55:12.155522Z","caller":"etcdserver/server.go:1856","msg":"sent merged snapshot","from":"eb6db91b2c71522f","to":"dd742632527f2650","bytes":794635,"size":"795 kB","took":"30.01250997s"} {"level":"warn","ts":"2026-04-18T17:55:31.173904Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"206.024424ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:55:31.174044Z","caller":"traceutil/trace.go:172","msg":"trace[1781985602] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"287.398834ms","start":"2026-04-18T17:55:30.886625Z","end":"2026-04-18T17:55:31.174024Z","steps":["trace[1781985602] 'process raft request' (duration: 80.994676ms)","trace[1781985602] 'compare' (duration: 205.699001ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:55:31.174672Z","caller":"etcdserver/raft.go:387","msg":"leader failed to send out heartbeat on time; took too long, leader is overloaded likely from slow disk","to":"dd742632527f2650","heartbeat-interval":"100ms","expected-duration":"200ms","exceeded-duration":"7.212666ms"} {"level":"info","ts":"2026-04-18T17:55:31.175291Z","caller":"traceutil/trace.go:172","msg":"trace[1342414288] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"231.019349ms","start":"2026-04-18T17:55:30.944257Z","end":"2026-04-18T17:55:31.175276Z","steps":["trace[1342414288] 'process raft request' (duration: 230.852457ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:55:31.175492Z","caller":"traceutil/trace.go:172","msg":"trace[64192306] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"260.184387ms","start":"2026-04-18T17:55:30.915297Z","end":"2026-04-18T17:55:31.175482Z","steps":["trace[64192306] 'process raft request' (duration: 259.693471ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:55:31.175465Z","caller":"traceutil/trace.go:172","msg":"trace[830412695] transaction","detail":"{read_only:false; number_of_response:1; response_revision:751; }","duration":"265.966192ms","start":"2026-04-18T17:55:30.909459Z","end":"2026-04-18T17:55:31.175425Z","steps":["trace[830412695] 'process raft request' (duration: 265.416437ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:55:31.185183Z","caller":"traceutil/trace.go:172","msg":"trace[987376545] linearizableReadLoop","detail":"{readStateIndex:817; appliedIndex:824; }","duration":"211.495198ms","start":"2026-04-18T17:55:30.973657Z","end":"2026-04-18T17:55:31.185152Z","steps":["trace[987376545] 'read index received' (duration: 211.461798ms)","trace[987376545] 'applied index is now lower than readState.Index' (duration: 31.51µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:55:31.185525Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"211.844111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:442"} {"level":"info","ts":"2026-04-18T17:55:31.185556Z","caller":"traceutil/trace.go:172","msg":"trace[1367909350] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:753; }","duration":"211.895642ms","start":"2026-04-18T17:55:30.973651Z","end":"2026-04-18T17:55:31.185547Z","steps":["trace[1367909350] 'agreement among raft nodes before linearized reading' (duration: 211.66152ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:55:31.314405Z","caller":"traceutil/trace.go:172","msg":"trace[59516253] linearizableReadLoop","detail":"{readStateIndex:824; appliedIndex:824; }","duration":"129.115549ms","start":"2026-04-18T17:55:31.185247Z","end":"2026-04-18T17:55:31.314362Z","steps":["trace[59516253] 'read index received' (duration: 129.109479ms)","trace[59516253] 'applied index is now lower than readState.Index' (duration: 4.91µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:55:31.455553Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"480.640161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-18T17:55:31.455646Z","caller":"traceutil/trace.go:172","msg":"trace[1423541891] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:753; }","duration":"480.747133ms","start":"2026-04-18T17:55:30.974878Z","end":"2026-04-18T17:55:31.455625Z","steps":["trace[1423541891] 'agreement among raft nodes before linearized reading' (duration: 339.611356ms)","trace[1423541891] 'range keys from in-memory index tree' (duration: 140.885993ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:55:31.455699Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:30.974872Z","time spent":"480.813003ms","remote":"127.0.0.1:40578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:55:31.456299Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"150.441528ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:55:31.456618Z","caller":"traceutil/trace.go:172","msg":"trace[1868265819] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"262.119965ms","start":"2026-04-18T17:55:31.194485Z","end":"2026-04-18T17:55:31.456605Z","steps":["trace[1868265819] 'process raft request' (duration: 262.038984ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:55:31.456653Z","caller":"traceutil/trace.go:172","msg":"trace[1429859185] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"425.871323ms","start":"2026-04-18T17:55:31.030751Z","end":"2026-04-18T17:55:31.456623Z","steps":["trace[1429859185] 'process raft request' (duration: 275.055732ms)","trace[1429859185] 'compare' (duration: 150.246376ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:55:31.456797Z","caller":"traceutil/trace.go:172","msg":"trace[954430002] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"268.589899ms","start":"2026-04-18T17:55:31.188195Z","end":"2026-04-18T17:55:31.456785Z","steps":["trace[954430002] 'process raft request' (duration: 268.222475ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:31.456839Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:31.030725Z","time spent":"426.025234ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T17:55:31.457013Z","caller":"traceutil/trace.go:172","msg":"trace[1965755957] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"264.626339ms","start":"2026-04-18T17:55:31.192377Z","end":"2026-04-18T17:55:31.457003Z","steps":["trace[1965755957] 'process raft request' (duration: 264.098934ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:35.409555Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44692","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:55:35.440458Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44732","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:55:35.460638Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44750","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:55:35.478412Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44756","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:55:35.500005Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44774","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:55:35.551355Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44808","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:55:35.564828Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44810","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:55:35.589310Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44838","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:55:35.629060Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44844","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:55:35.661531Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44860","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:55:35.679079Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44882","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:55:35.697106Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44892","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:55:35.717770Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44910","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:55:35.813417Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44938","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:55:35.855870Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44954","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:55:35.998228Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44970","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:55:36.092094Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44990","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:55:36.184661Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:45002","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:55:36.208000Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:45006","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:55:36.232058Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:45022","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:55:36.262706Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:45040","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:55:36.283401Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:45050","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:55:36.300386Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:45074","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:55:36.311213Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:45104","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:55:36.326693Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:45118","server-name":"","error":"EOF"} {"level":"info","ts":"2026-04-18T17:55:36.821993Z","caller":"traceutil/trace.go:172","msg":"trace[628831983] transaction","detail":"{read_only:false; response_revision:821; number_of_response:1; }","duration":"174.393968ms","start":"2026-04-18T17:55:36.647582Z","end":"2026-04-18T17:55:36.821976Z","steps":["trace[628831983] 'process raft request' (duration: 173.594141ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:55:36.825551Z","caller":"traceutil/trace.go:172","msg":"trace[1226228413] linearizableReadLoop","detail":"{readStateIndex:919; appliedIndex:920; }","duration":"137.250334ms","start":"2026-04-18T17:55:36.688263Z","end":"2026-04-18T17:55:36.825513Z","steps":["trace[1226228413] 'read index received' (duration: 137.227154ms)","trace[1226228413] 'applied index is now lower than readState.Index' (duration: 7.12µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:55:36.826066Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"137.78465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:55:36.826143Z","caller":"traceutil/trace.go:172","msg":"trace[436679730] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes; range_end:; response_count:0; response_revision:822; }","duration":"137.886131ms","start":"2026-04-18T17:55:36.688242Z","end":"2026-04-18T17:55:36.826128Z","steps":["trace[436679730] 'agreement among raft nodes before linearized reading' (duration: 137.394686ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:36.827415Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"110.146788ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T17:55:36.827415Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"119.4525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:55:36.827499Z","caller":"traceutil/trace.go:172","msg":"trace[1378202083] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies; range_end:; response_count:0; response_revision:823; }","duration":"119.560601ms","start":"2026-04-18T17:55:36.707921Z","end":"2026-04-18T17:55:36.827481Z","steps":["trace[1378202083] 'agreement among raft nodes before linearized reading' (duration: 119.42144ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:55:36.827504Z","caller":"traceutil/trace.go:172","msg":"trace[1548945439] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:823; }","duration":"110.198549ms","start":"2026-04-18T17:55:36.717255Z","end":"2026-04-18T17:55:36.827454Z","steps":["trace[1548945439] 'agreement among raft nodes before linearized reading' (duration: 110.120988ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:55:37.684977Z","caller":"traceutil/trace.go:172","msg":"trace[1865686379] transaction","detail":"{read_only:false; response_revision:831; number_of_response:1; }","duration":"231.625847ms","start":"2026-04-18T17:55:37.453329Z","end":"2026-04-18T17:55:37.684955Z","steps":["trace[1865686379] 'process raft request' (duration: 231.372075ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:55:37.686261Z","caller":"traceutil/trace.go:172","msg":"trace[702457377] linearizableReadLoop","detail":"{readStateIndex:930; appliedIndex:931; }","duration":"188.230013ms","start":"2026-04-18T17:55:37.498009Z","end":"2026-04-18T17:55:37.686239Z","steps":["trace[702457377] 'read index received' (duration: 188.221913ms)","trace[702457377] 'applied index is now lower than readState.Index' (duration: 6.41µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:55:37.686542Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"188.513087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-18T17:55:37.686602Z","caller":"traceutil/trace.go:172","msg":"trace[1931821676] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:831; }","duration":"188.596347ms","start":"2026-04-18T17:55:37.497993Z","end":"2026-04-18T17:55:37.686589Z","steps":["trace[1931821676] 'agreement among raft nodes before linearized reading' (duration: 188.348245ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:55:37.686981Z","caller":"traceutil/trace.go:172","msg":"trace[1337042052] transaction","detail":"{read_only:false; response_revision:832; number_of_response:1; }","duration":"194.506085ms","start":"2026-04-18T17:55:37.492370Z","end":"2026-04-18T17:55:37.686877Z","steps":["trace[1337042052] 'process raft request' (duration: 193.96774ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:37.687352Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"187.579426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:442"} {"level":"info","ts":"2026-04-18T17:55:37.687501Z","caller":"traceutil/trace.go:172","msg":"trace[235484151] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:832; }","duration":"187.750408ms","start":"2026-04-18T17:55:37.499732Z","end":"2026-04-18T17:55:37.687483Z","steps":["trace[235484151] 'agreement among raft nodes before linearized reading' (duration: 187.433075ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:38.152760Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"152.277219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-7zbwt\" limit:1 ","response":"range_response_count:1 size:18354"} {"level":"info","ts":"2026-04-18T17:55:38.152867Z","caller":"traceutil/trace.go:172","msg":"trace[853822940] range","detail":"{range_begin:/registry/pods/kube-system/cilium-7zbwt; range_end:; response_count:1; response_revision:835; }","duration":"152.40787ms","start":"2026-04-18T17:55:38.000441Z","end":"2026-04-18T17:55:38.152849Z","steps":["trace[853822940] 'range keys from in-memory index tree' (duration: 151.058288ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:55:38.245376Z","caller":"traceutil/trace.go:172","msg":"trace[66887342] transaction","detail":"{read_only:false; response_revision:836; number_of_response:1; }","duration":"131.033922ms","start":"2026-04-18T17:55:38.114319Z","end":"2026-04-18T17:55:38.245353Z","steps":["trace[66887342] 'process raft request' (duration: 130.307355ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:38.699800Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5922125352956341171,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:55:39.200144Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5922125352956341171,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:55:39.229847Z","caller":"etcdserver/raft.go:387","msg":"leader failed to send out heartbeat on time; took too long, leader is overloaded likely from slow disk","to":"dd742632527f2650","heartbeat-interval":"100ms","expected-duration":"200ms","exceeded-duration":"785.538152ms"} {"level":"info","ts":"2026-04-18T17:55:39.229911Z","caller":"traceutil/trace.go:172","msg":"trace[588910449] linearizableReadLoop","detail":"{readStateIndex:935; appliedIndex:936; }","duration":"1.030485461s","start":"2026-04-18T17:55:38.199382Z","end":"2026-04-18T17:55:39.229867Z","steps":["trace[588910449] 'read index received' (duration: 1.030472631s)","trace[588910449] 'applied index is now lower than readState.Index' (duration: 11.18µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:55:39.230186Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.030780894s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:55:39.230233Z","caller":"traceutil/trace.go:172","msg":"trace[837975118] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:836; }","duration":"1.030850134s","start":"2026-04-18T17:55:38.199370Z","end":"2026-04-18T17:55:39.230220Z","steps":["trace[837975118] 'agreement among raft nodes before linearized reading' (duration: 1.030719743s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:39.230274Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:38.199352Z","time spent":"1.030914306s","remote":"127.0.0.1:40054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-18T17:55:39.230512Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:38.153710Z","time spent":"1.076792033s","remote":"127.0.0.1:40090","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-18T17:55:39.230557Z","caller":"traceutil/trace.go:172","msg":"trace[1571836089] transaction","detail":"{read_only:false; response_revision:837; number_of_response:1; }","duration":"1.059987279s","start":"2026-04-18T17:55:38.170548Z","end":"2026-04-18T17:55:39.230535Z","steps":["trace[1571836089] 'process raft request' (duration: 1.059837288s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:39.230710Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:38.170517Z","time spent":"1.0600973s","remote":"127.0.0.1:40436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18511,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T17:55:39.529760Z","caller":"etcdserver/raft.go:387","msg":"leader failed to send out heartbeat on time; took too long, leader is overloaded likely from slow disk","to":"dd742632527f2650","heartbeat-interval":"100ms","expected-duration":"200ms","exceeded-duration":"99.838931ms"} {"level":"warn","ts":"2026-04-18T17:55:39.529850Z","caller":"etcdserver/v3_server.go:888","msg":"ignored out-of-date read index response; local node read indexes queueing up and waiting to be in sync with leader","sent-request-id":5922125352956341180,"received-request-id":5922125352956341171} {"level":"info","ts":"2026-04-18T17:55:39.539756Z","caller":"traceutil/trace.go:172","msg":"trace[312583625] linearizableReadLoop","detail":"{readStateIndex:938; appliedIndex:938; }","duration":"309.698647ms","start":"2026-04-18T17:55:39.230031Z","end":"2026-04-18T17:55:39.539730Z","steps":["trace[312583625] 'read index received' (duration: 309.687977ms)","trace[312583625] 'applied index is now lower than readState.Index' (duration: 7.39µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:55:39.561774Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.208041676s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourceclaims\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:55:39.561890Z","caller":"traceutil/trace.go:172","msg":"trace[935439601] range","detail":"{range_begin:/registry/resourceclaims; range_end:; response_count:0; response_revision:837; }","duration":"1.208175977s","start":"2026-04-18T17:55:38.353685Z","end":"2026-04-18T17:55:39.561861Z","steps":["trace[935439601] 'agreement among raft nodes before linearized reading' (duration: 1.186166122s)","trace[935439601] 'range keys from in-memory index tree' (duration: 21.837543ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:55:39.561948Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:38.353662Z","time spent":"1.208274628s","remote":"127.0.0.1:41084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":0,"response size":29,"request content":"key:\"/registry/resourceclaims\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:55:39.562292Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.168403768s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:55:39.562361Z","caller":"traceutil/trace.go:172","msg":"trace[1879340109] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions; range_end:; response_count:0; response_revision:837; }","duration":"1.168483678s","start":"2026-04-18T17:55:38.393860Z","end":"2026-04-18T17:55:39.562344Z","steps":["trace[1879340109] 'agreement among raft nodes before linearized reading' (duration: 1.145964778s)","trace[1879340109] 'range keys from in-memory index tree' (duration: 22.401969ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:55:39.562409Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:38.393847Z","time spent":"1.168555529s","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:55:39.562574Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"846.70115ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:55:39.562595Z","caller":"traceutil/trace.go:172","msg":"trace[568828598] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:837; }","duration":"846.7201ms","start":"2026-04-18T17:55:38.715869Z","end":"2026-04-18T17:55:39.562589Z","steps":["trace[568828598] 'agreement among raft nodes before linearized reading' (duration: 823.932627ms)","trace[568828598] 'range keys from in-memory index tree' (duration: 22.756733ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:55:39.563590Z","caller":"traceutil/trace.go:172","msg":"trace[2111236709] transaction","detail":"{read_only:false; response_revision:839; number_of_response:1; }","duration":"1.25548704s","start":"2026-04-18T17:55:38.308072Z","end":"2026-04-18T17:55:39.563559Z","steps":["trace[2111236709] 'process raft request' (duration: 1.254707973s)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:55:39.564257Z","caller":"traceutil/trace.go:172","msg":"trace[1049047829] transaction","detail":"{read_only:false; response_revision:840; number_of_response:1; }","duration":"730.369852ms","start":"2026-04-18T17:55:38.833862Z","end":"2026-04-18T17:55:39.564232Z","steps":["trace[1049047829] 'process raft request' (duration: 729.591655ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:39.564419Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:38.833826Z","time spent":"730.500024ms","remote":"127.0.0.1:40578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T17:55:39.564579Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:38.308042Z","time spent":"1.25557211s","remote":"127.0.0.1:41030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T17:55:39.564866Z","caller":"traceutil/trace.go:172","msg":"trace[1316446421] transaction","detail":"{read_only:false; response_revision:841; number_of_response:1; }","duration":"730.865657ms","start":"2026-04-18T17:55:38.833988Z","end":"2026-04-18T17:55:39.564853Z","steps":["trace[1316446421] 'process raft request' (duration: 730.179421ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:55:39.565913Z","caller":"traceutil/trace.go:172","msg":"trace[182829329] transaction","detail":"{read_only:false; response_revision:842; number_of_response:1; }","duration":"612.075596ms","start":"2026-04-18T17:55:38.953810Z","end":"2026-04-18T17:55:39.565885Z","steps":["trace[182829329] 'process raft request' (duration: 610.952624ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:39.565982Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:38.833969Z","time spent":"731.940898ms","remote":"127.0.0.1:40578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":468,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T17:55:39.566055Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:38.953778Z","time spent":"612.216997ms","remote":"127.0.0.1:40578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":677,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:55:39.583324Z","caller":"traceutil/trace.go:172","msg":"trace[1600421869] transaction","detail":"{read_only:false; response_revision:843; number_of_response:1; }","duration":"351.595838ms","start":"2026-04-18T17:55:39.231710Z","end":"2026-04-18T17:55:39.583306Z","steps":["trace[1600421869] 'process raft request' (duration: 351.486737ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:39.583431Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:39.231684Z","time spent":"351.694919ms","remote":"127.0.0.1:40090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T17:55:39.584488Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"343.177745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:55:39.585167Z","caller":"traceutil/trace.go:172","msg":"trace[1013501840] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:843; }","duration":"343.822132ms","start":"2026-04-18T17:55:39.241290Z","end":"2026-04-18T17:55:39.585112Z","steps":["trace[1013501840] 'agreement among raft nodes before linearized reading' (duration: 343.008523ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:39.585214Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:39.241266Z","time spent":"343.931423ms","remote":"127.0.0.1:40032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-18T17:55:40.201433Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5922125352956341188,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:55:40.444637Z","caller":"etcdserver/raft.go:387","msg":"leader failed to send out heartbeat on time; took too long, leader is overloaded likely from slow disk","to":"dd742632527f2650","heartbeat-interval":"100ms","expected-duration":"200ms","exceeded-duration":"651.847966ms"} {"level":"warn","ts":"2026-04-18T17:55:40.446138Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"729.943345ms","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-04-18T17:55:40.446246Z","caller":"traceutil/trace.go:172","msg":"trace[114293839] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:843; }","duration":"730.071536ms","start":"2026-04-18T17:55:39.716154Z","end":"2026-04-18T17:55:40.446226Z","steps":["trace[114293839] 'range keys from in-memory index tree' (duration: 729.888743ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:40.702125Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5922125352956341188,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:55:41.203153Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5922125352956341188,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-18T17:55:41.517910Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1101","msg":"eb6db91b2c71522f [logterm: 2, index: 950, vote: eb6db91b2c71522f] ignored MsgPreVote from dd742632527f2650 [logterm: 2, index: 947] at term 2: lease is not expired (remaining ticks: 5)"} {"level":"warn","ts":"2026-04-18T17:55:41.703298Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5922125352956341188,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T17:55:41.830701Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.382988149s","expected-duration":"1s"} {"level":"info","ts":"2026-04-18T17:55:41.832007Z","caller":"traceutil/trace.go:172","msg":"trace[1729694151] linearizableReadLoop","detail":"{readStateIndex:944; appliedIndex:945; }","duration":"2.131159511s","start":"2026-04-18T17:55:39.700736Z","end":"2026-04-18T17:55:41.831895Z","steps":["trace[1729694151] 'read index received' (duration: 2.131149621s)","trace[1729694151] 'applied index is now lower than readState.Index' (duration: 7.6µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:55:41.832682Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.131874298s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:442"} {"level":"info","ts":"2026-04-18T17:55:41.832796Z","caller":"traceutil/trace.go:172","msg":"trace[1901989999] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:844; }","duration":"2.132054679s","start":"2026-04-18T17:55:39.700720Z","end":"2026-04-18T17:55:41.832775Z","steps":["trace[1901989999] 'agreement among raft nodes before linearized reading' (duration: 2.131480064s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:41.832880Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:39.700687Z","time spent":"2.13217664s","remote":"127.0.0.1:40578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":466,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:55:41.833331Z","caller":"etcdserver/raft.go:387","msg":"leader failed to send out heartbeat on time; took too long, leader is overloaded likely from slow disk","to":"dd742632527f2650","heartbeat-interval":"100ms","expected-duration":"200ms","exceeded-duration":"1.18712226s"} {"level":"warn","ts":"2026-04-18T17:55:41.838049Z","caller":"etcdserver/v3_server.go:888","msg":"ignored out-of-date read index response; local node read indexes queueing up and waiting to be in sync with leader","sent-request-id":5922125352956341192,"received-request-id":5922125352956341188} {"level":"info","ts":"2026-04-18T17:55:41.840622Z","caller":"traceutil/trace.go:172","msg":"trace[923745447] transaction","detail":"{read_only:false; response_revision:846; number_of_response:1; }","duration":"1.853418355s","start":"2026-04-18T17:55:39.987190Z","end":"2026-04-18T17:55:41.840608Z","steps":["trace[923745447] 'process raft request' (duration: 1.85193824s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:41.840736Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:39.987152Z","time spent":"1.853511807s","remote":"127.0.0.1:40220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036317,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T17:55:41.840962Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"642.603456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T17:55:41.841018Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"901.814497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingadmissionpolicies\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:55:41.841047Z","caller":"traceutil/trace.go:172","msg":"trace[579069941] range","detail":"{range_begin:/registry/validatingadmissionpolicies; range_end:; response_count:0; response_revision:847; }","duration":"901.844757ms","start":"2026-04-18T17:55:40.939195Z","end":"2026-04-18T17:55:41.841040Z","steps":["trace[579069941] 'agreement among raft nodes before linearized reading' (duration: 901.511574ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:41.841071Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:40.939167Z","time spent":"901.897477ms","remote":"127.0.0.1:41044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":29,"request content":"key:\"/registry/validatingadmissionpolicies\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:55:41.841087Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.136366512s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-18T17:55:41.841115Z","caller":"traceutil/trace.go:172","msg":"trace[1830369009] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:847; }","duration":"2.136394002s","start":"2026-04-18T17:55:39.704713Z","end":"2026-04-18T17:55:41.841107Z","steps":["trace[1830369009] 'agreement among raft nodes before linearized reading' (duration: 2.135931757s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:41.841163Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:39.704706Z","time spent":"2.136450262s","remote":"127.0.0.1:40578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"info","ts":"2026-04-18T17:55:41.841051Z","caller":"traceutil/trace.go:172","msg":"trace[868491788] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:847; }","duration":"642.703357ms","start":"2026-04-18T17:55:41.198328Z","end":"2026-04-18T17:55:41.841031Z","steps":["trace[868491788] 'agreement among raft nodes before linearized reading' (duration: 642.361104ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:41.841308Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.395010236s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T17:55:41.841330Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:41.198289Z","time spent":"643.02934ms","remote":"127.0.0.1:40032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-18T17:55:41.841338Z","caller":"traceutil/trace.go:172","msg":"trace[1770707290] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:847; }","duration":"1.395040577s","start":"2026-04-18T17:55:40.446290Z","end":"2026-04-18T17:55:41.841330Z","steps":["trace[1770707290] 'agreement among raft nodes before linearized reading' (duration: 1.394376811s)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:55:41.841566Z","caller":"traceutil/trace.go:172","msg":"trace[157357222] transaction","detail":"{read_only:false; response_revision:850; number_of_response:1; }","duration":"271.094688ms","start":"2026-04-18T17:55:41.570463Z","end":"2026-04-18T17:55:41.841558Z","steps":["trace[157357222] 'process raft request' (duration: 270.948387ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:41.841656Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.037601076s","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-04-18T17:55:41.841908Z","caller":"traceutil/trace.go:172","msg":"trace[2101654700] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:847; }","duration":"2.037850608s","start":"2026-04-18T17:55:39.804042Z","end":"2026-04-18T17:55:41.841892Z","steps":["trace[2101654700] 'agreement among raft nodes before linearized reading' (duration: 2.036652247s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:41.841947Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:39.804015Z","time spent":"2.037921959s","remote":"127.0.0.1:40244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":1,"response size":375,"request content":"key:\"/registry/namespaces/kube-system\" limit:1 "} {"level":"info","ts":"2026-04-18T17:55:41.841742Z","caller":"traceutil/trace.go:172","msg":"trace[1830639279] transaction","detail":"{read_only:false; response_revision:851; number_of_response:1; }","duration":"268.117459ms","start":"2026-04-18T17:55:41.573613Z","end":"2026-04-18T17:55:41.841731Z","steps":["trace[1830639279] 'process raft request' (duration: 267.922027ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:41.843572Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.789074618s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" keys_only:true ","response":"range_response_count:74 size:6228"} {"level":"info","ts":"2026-04-18T17:55:41.843612Z","caller":"traceutil/trace.go:172","msg":"trace[1247201737] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:74; response_revision:847; }","duration":"1.789134668s","start":"2026-04-18T17:55:40.054469Z","end":"2026-04-18T17:55:41.843604Z","steps":["trace[1247201737] 'agreement among raft nodes before linearized reading' (duration: 1.78621159s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:41.843634Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:40.054448Z","time spent":"1.789178398s","remote":"127.0.0.1:40168","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":74,"response size":6252,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" keys_only:true "} {"level":"info","ts":"2026-04-18T17:55:44.491482Z","caller":"traceutil/trace.go:172","msg":"trace[919774655] transaction","detail":"{read_only:false; response_revision:901; number_of_response:1; }","duration":"380.868393ms","start":"2026-04-18T17:55:44.110591Z","end":"2026-04-18T17:55:44.491459Z","steps":["trace[919774655] 'process raft request' (duration: 380.713811ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:44.491617Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:44.110543Z","time spent":"381.004153ms","remote":"127.0.0.1:40436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T17:55:44.491152Z","caller":"etcdserver/raft.go:387","msg":"leader failed to send out heartbeat on time; took too long, leader is overloaded likely from slow disk","to":"dd742632527f2650","heartbeat-interval":"100ms","expected-duration":"200ms","exceeded-duration":"199.353913ms"} {"level":"info","ts":"2026-04-18T17:55:44.493305Z","caller":"traceutil/trace.go:172","msg":"trace[350342458] linearizableReadLoop","detail":"{readStateIndex:1003; appliedIndex:1004; }","duration":"334.815324ms","start":"2026-04-18T17:55:44.158474Z","end":"2026-04-18T17:55:44.493289Z","steps":["trace[350342458] 'read index received' (duration: 334.809614ms)","trace[350342458] 'applied index is now lower than readState.Index' (duration: 4.94µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:55:44.493647Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"335.141247ms","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-04-18T17:55:44.493838Z","caller":"traceutil/trace.go:172","msg":"trace[1784562806] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:901; }","duration":"335.352059ms","start":"2026-04-18T17:55:44.158457Z","end":"2026-04-18T17:55:44.493809Z","steps":["trace[1784562806] 'agreement among raft nodes before linearized reading' (duration: 334.893354ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:44.493902Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:44.158426Z","time spent":"335.459579ms","remote":"127.0.0.1:40244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":1,"response size":375,"request content":"key:\"/registry/namespaces/kube-system\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:55:44.719772Z","caller":"etcdserver/raft.go:387","msg":"leader failed to send out heartbeat on time; took too long, leader is overloaded likely from slow disk","to":"dd742632527f2650","heartbeat-interval":"100ms","expected-duration":"200ms","exceeded-duration":"6.710965ms"} {"level":"warn","ts":"2026-04-18T17:55:46.431033Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"169.361238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:55:46.431166Z","caller":"traceutil/trace.go:172","msg":"trace[1863845988] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:0; response_revision:929; }","duration":"169.50649ms","start":"2026-04-18T17:55:46.261639Z","end":"2026-04-18T17:55:46.431145Z","steps":["trace[1863845988] 'range keys from in-memory index tree' (duration: 168.414799ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:46.431469Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"132.050366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:55:46.431579Z","caller":"traceutil/trace.go:172","msg":"trace[876666766] range","detail":"{range_begin:/registry/priorityclasses; range_end:; response_count:0; response_revision:929; }","duration":"132.170468ms","start":"2026-04-18T17:55:46.299388Z","end":"2026-04-18T17:55:46.431558Z","steps":["trace[876666766] 'range keys from in-memory index tree' (duration: 131.108155ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:47.137304Z","caller":"etcdserver/raft.go:387","msg":"leader failed to send out heartbeat on time; took too long, leader is overloaded likely from slow disk","to":"dd742632527f2650","heartbeat-interval":"100ms","expected-duration":"200ms","exceeded-duration":"123.6032ms"} {"level":"info","ts":"2026-04-18T17:55:47.137784Z","caller":"traceutil/trace.go:172","msg":"trace[1198228424] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"218.051913ms","start":"2026-04-18T17:55:46.919703Z","end":"2026-04-18T17:55:47.137754Z","steps":["trace[1198228424] 'process raft request' (duration: 217.810871ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:55:47.200870Z","caller":"traceutil/trace.go:172","msg":"trace[740300997] linearizableReadLoop","detail":"{readStateIndex:1059; appliedIndex:1061; }","duration":"173.71251ms","start":"2026-04-18T17:55:47.026973Z","end":"2026-04-18T17:55:47.200685Z","steps":["trace[740300997] 'read index received' (duration: 173.70428ms)","trace[740300997] 'applied index is now lower than readState.Index' (duration: 7.03µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:55:47.314586Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"287.59234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T17:55:47.315313Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"114.492135ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:55:47.314727Z","caller":"traceutil/trace.go:172","msg":"trace[994613614] range","detail":"{range_begin:/registry/resourcequotas; range_end:; response_count:0; response_revision:948; }","duration":"287.722242ms","start":"2026-04-18T17:55:47.026955Z","end":"2026-04-18T17:55:47.314677Z","steps":["trace[994613614] 'agreement among raft nodes before linearized reading' (duration: 173.898563ms)","trace[994613614] 'range keys from in-memory index tree' (duration: 113.647317ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:55:47.315541Z","caller":"traceutil/trace.go:172","msg":"trace[2017560225] linearizableReadLoop","detail":"{readStateIndex:1062; appliedIndex:1061; }","duration":"114.536905ms","start":"2026-04-18T17:55:47.200985Z","end":"2026-04-18T17:55:47.315522Z","steps":["trace[2017560225] 'read index received' (duration: 951.23µs)","trace[2017560225] 'applied index is now lower than readState.Index' (duration: 113.584065ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:55:47.315625Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"267.868638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:55:47.315659Z","caller":"traceutil/trace.go:172","msg":"trace[1480050087] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:950; }","duration":"267.904849ms","start":"2026-04-18T17:55:47.047742Z","end":"2026-04-18T17:55:47.315647Z","steps":["trace[1480050087] 'agreement among raft nodes before linearized reading' (duration: 267.836178ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:47.315663Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"225.320003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:55:47.315755Z","caller":"traceutil/trace.go:172","msg":"trace[376073047] range","detail":"{range_begin:/registry/podtemplates; range_end:; response_count:0; response_revision:950; }","duration":"225.435515ms","start":"2026-04-18T17:55:47.090300Z","end":"2026-04-18T17:55:47.315736Z","steps":["trace[376073047] 'agreement among raft nodes before linearized reading' (duration: 225.249073ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:47.316049Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"116.836156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:55:47.316079Z","caller":"traceutil/trace.go:172","msg":"trace[1701307738] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:950; }","duration":"116.863467ms","start":"2026-04-18T17:55:47.199205Z","end":"2026-04-18T17:55:47.316069Z","steps":["trace[1701307738] 'agreement among raft nodes before linearized reading' (duration: 116.808416ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:55:47.315595Z","caller":"traceutil/trace.go:172","msg":"trace[1094878499] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"246.48875ms","start":"2026-04-18T17:55:47.068960Z","end":"2026-04-18T17:55:47.315449Z","steps":["trace[1094878499] 'process raft request' (duration: 131.797303ms)","trace[1094878499] 'compare' (duration: 114.01823ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:55:47.316768Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"249.914994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-7zbwt\" limit:1 ","response":"range_response_count:1 size:19670"} {"level":"info","ts":"2026-04-18T17:55:47.316968Z","caller":"traceutil/trace.go:172","msg":"trace[1602309507] range","detail":"{range_begin:/registry/pods/kube-system/cilium-7zbwt; range_end:; response_count:1; response_revision:950; }","duration":"250.113956ms","start":"2026-04-18T17:55:47.066840Z","end":"2026-04-18T17:55:47.316954Z","steps":["trace[1602309507] 'agreement among raft nodes before linearized reading' (duration: 249.011975ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:47.563082Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"143.606267ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-18T17:55:47.563622Z","caller":"traceutil/trace.go:172","msg":"trace[772803565] transaction","detail":"{read_only:false; response_revision:952; number_of_response:1; }","duration":"230.703586ms","start":"2026-04-18T17:55:47.332899Z","end":"2026-04-18T17:55:47.563602Z","steps":["trace[772803565] 'process raft request' (duration: 230.531235ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:55:47.563781Z","caller":"traceutil/trace.go:172","msg":"trace[1893289329] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"313.919826ms","start":"2026-04-18T17:55:47.249805Z","end":"2026-04-18T17:55:47.563725Z","steps":["trace[1893289329] 'process raft request' (duration: 313.439311ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:47.563977Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:47.249772Z","time spent":"314.119068ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9343,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T17:55:47.613069Z","caller":"traceutil/trace.go:172","msg":"trace[1801430381] transaction","detail":"{read_only:false; response_revision:954; number_of_response:1; }","duration":"162.949086ms","start":"2026-04-18T17:55:47.450091Z","end":"2026-04-18T17:55:47.613040Z","steps":["trace[1801430381] 'process raft request' (duration: 162.888996ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:55:47.779346Z","caller":"traceutil/trace.go:172","msg":"trace[1261805880] transaction","detail":"{read_only:false; number_of_response:1; response_revision:954; }","duration":"204.881336ms","start":"2026-04-18T17:55:47.574439Z","end":"2026-04-18T17:55:47.779320Z","steps":["trace[1261805880] 'process raft request' (duration: 204.753215ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:55:47.994642Z","caller":"traceutil/trace.go:172","msg":"trace[1135812761] linearizableReadLoop","detail":"{readStateIndex:1068; appliedIndex:1069; }","duration":"271.29495ms","start":"2026-04-18T17:55:47.723313Z","end":"2026-04-18T17:55:47.994608Z","steps":["trace[1135812761] 'read index received' (duration: 271.28099ms)","trace[1135812761] 'applied index is now lower than readState.Index' (duration: 11.65µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:55:47.994889Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"271.541263ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:55:47.994987Z","caller":"traceutil/trace.go:172","msg":"trace[88042331] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:954; }","duration":"271.664774ms","start":"2026-04-18T17:55:47.723301Z","end":"2026-04-18T17:55:47.994966Z","steps":["trace[88042331] 'agreement among raft nodes before linearized reading' (duration: 271.479162ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:55:47.995363Z","caller":"traceutil/trace.go:172","msg":"trace[1368936272] transaction","detail":"{read_only:false; response_revision:957; number_of_response:1; }","duration":"344.830776ms","start":"2026-04-18T17:55:47.650499Z","end":"2026-04-18T17:55:47.995330Z","steps":["trace[1368936272] 'process raft request' (duration: 344.737945ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:55:47.995546Z","caller":"traceutil/trace.go:172","msg":"trace[766441982] transaction","detail":"{read_only:false; number_of_response:1; response_revision:956; }","duration":"370.981681ms","start":"2026-04-18T17:55:47.624436Z","end":"2026-04-18T17:55:47.995417Z","steps":["trace[766441982] 'process raft request' (duration: 370.700859ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:47.995566Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:47.650464Z","time spent":"345.009128ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T17:55:47.995687Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:47.624322Z","time spent":"371.277374ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":99,"response count":0,"response size":10412,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T17:55:48.004747Z","caller":"etcdserver/raft.go:387","msg":"leader failed to send out heartbeat on time; took too long, leader is overloaded likely from slow disk","to":"dd742632527f2650","heartbeat-interval":"100ms","expected-duration":"200ms","exceeded-duration":"25.645355ms"} {"level":"info","ts":"2026-04-18T17:55:48.005231Z","caller":"traceutil/trace.go:172","msg":"trace[1970624288] transaction","detail":"{read_only:false; number_of_response:1; response_revision:957; }","duration":"214.037762ms","start":"2026-04-18T17:55:47.791153Z","end":"2026-04-18T17:55:48.005191Z","steps":["trace[1970624288] 'process raft request' (duration: 213.749499ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:55:48.005347Z","caller":"traceutil/trace.go:172","msg":"trace[511825602] transaction","detail":"{read_only:false; response_revision:958; number_of_response:1; }","duration":"153.005178ms","start":"2026-04-18T17:55:47.852312Z","end":"2026-04-18T17:55:48.005317Z","steps":["trace[511825602] 'process raft request' (duration: 152.698315ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:55:48.005563Z","caller":"traceutil/trace.go:172","msg":"trace[420879560] transaction","detail":"{read_only:false; response_revision:959; number_of_response:1; }","duration":"134.490719ms","start":"2026-04-18T17:55:47.871017Z","end":"2026-04-18T17:55:48.005508Z","steps":["trace[420879560] 'process raft request' (duration: 134.137556ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:55:48.147827Z","caller":"traceutil/trace.go:172","msg":"trace[899045581] linearizableReadLoop","detail":"{readStateIndex:1073; appliedIndex:1077; }","duration":"153.049859ms","start":"2026-04-18T17:55:47.994728Z","end":"2026-04-18T17:55:48.147778Z","steps":["trace[899045581] 'read index received' (duration: 153.029279ms)","trace[899045581] 'applied index is now lower than readState.Index' (duration: 17.94µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:55:48.148117Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"207.129396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-18T17:55:48.148204Z","caller":"traceutil/trace.go:172","msg":"trace[1884812798] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:961; }","duration":"207.245257ms","start":"2026-04-18T17:55:47.940942Z","end":"2026-04-18T17:55:48.148187Z","steps":["trace[1884812798] 'agreement among raft nodes before linearized reading' (duration: 206.862373ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:48.148228Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"209.183445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:442"} {"level":"info","ts":"2026-04-18T17:55:48.148277Z","caller":"traceutil/trace.go:172","msg":"trace[764436853] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:961; }","duration":"209.260135ms","start":"2026-04-18T17:55:47.938999Z","end":"2026-04-18T17:55:48.148259Z","steps":["trace[764436853] 'agreement among raft nodes before linearized reading' (duration: 209.001493ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:48.358998Z","caller":"etcdserver/raft.go:387","msg":"leader failed to send out heartbeat on time; took too long, leader is overloaded likely from slow disk","to":"dd742632527f2650","heartbeat-interval":"100ms","expected-duration":"200ms","exceeded-duration":"11.483839ms"} {"level":"info","ts":"2026-04-18T17:55:48.359398Z","caller":"traceutil/trace.go:172","msg":"trace[53002658] transaction","detail":"{read_only:false; number_of_response:1; response_revision:961; }","duration":"352.727602ms","start":"2026-04-18T17:55:48.006628Z","end":"2026-04-18T17:55:48.359356Z","steps":["trace[53002658] 'process raft request' (duration: 352.4542ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:55:48.359588Z","caller":"traceutil/trace.go:172","msg":"trace[884137655] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"284.567379ms","start":"2026-04-18T17:55:48.075010Z","end":"2026-04-18T17:55:48.359577Z","steps":["trace[884137655] 'process raft request' (duration: 284.489729ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:48.359650Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:48.006601Z","time spent":"352.919215ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":87,"response count":0,"response size":4118,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:55:48.359725Z","caller":"traceutil/trace.go:172","msg":"trace[1443083113] transaction","detail":"{read_only:false; number_of_response:1; response_revision:962; }","duration":"346.989146ms","start":"2026-04-18T17:55:48.012708Z","end":"2026-04-18T17:55:48.359697Z","steps":["trace[1443083113] 'process raft request' (duration: 346.680483ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:48.359862Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:48.012686Z","time spent":"347.095977ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":96,"response count":0,"response size":9346,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:55:48.401820Z","caller":"traceutil/trace.go:172","msg":"trace[1918667837] linearizableReadLoop","detail":"{readStateIndex:1078; appliedIndex:1082; }","duration":"253.85889ms","start":"2026-04-18T17:55:48.147937Z","end":"2026-04-18T17:55:48.401796Z","steps":["trace[1918667837] 'read index received' (duration: 253.84601ms)","trace[1918667837] 'applied index is now lower than readState.Index' (duration: 11.66µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:55:48.561366Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"514.233064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T17:55:48.561414Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"504.841751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.105\" limit:1 ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-18T17:55:48.561476Z","caller":"traceutil/trace.go:172","msg":"trace[1536508708] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:963; }","duration":"514.386085ms","start":"2026-04-18T17:55:48.047065Z","end":"2026-04-18T17:55:48.561451Z","steps":["trace[1536508708] 'agreement among raft nodes before linearized reading' (duration: 354.859152ms)","trace[1536508708] 'range keys from in-memory index tree' (duration: 159.357381ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:55:48.561488Z","caller":"traceutil/trace.go:172","msg":"trace[1649079419] range","detail":"{range_begin:/registry/masterleases/199.19.213.105; range_end:; response_count:1; response_revision:963; }","duration":"505.014043ms","start":"2026-04-18T17:55:48.056453Z","end":"2026-04-18T17:55:48.561467Z","steps":["trace[1649079419] 'agreement among raft nodes before linearized reading' (duration: 345.359559ms)","trace[1649079419] 'range keys from in-memory index tree' (duration: 159.335321ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:55:48.561531Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:48.056424Z","time spent":"505.094414ms","remote":"127.0.0.1:40090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.19.213.105\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:55:48.561539Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:48.047045Z","time spent":"514.465376ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":92,"response count":0,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:55:48.561860Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"159.938567ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T17:55:48.562086Z","caller":"traceutil/trace.go:172","msg":"trace[516048872] transaction","detail":"{read_only:false; response_revision:964; number_of_response:1; }","duration":"407.701466ms","start":"2026-04-18T17:55:48.154365Z","end":"2026-04-18T17:55:48.562066Z","steps":["trace[516048872] 'process raft request' (duration: 247.438346ms)","trace[516048872] 'compare' (duration: 159.24473ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:55:48.562188Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:48.154332Z","time spent":"407.797048ms","remote":"127.0.0.1:40578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T17:55:48.562248Z","caller":"traceutil/trace.go:172","msg":"trace[645760319] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"406.632966ms","start":"2026-04-18T17:55:48.155597Z","end":"2026-04-18T17:55:48.562230Z","steps":["trace[645760319] 'process raft request' (duration: 406.442314ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:48.562545Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:48.155574Z","time spent":"406.830738ms","remote":"127.0.0.1:40578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":427,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T17:55:48.648662Z","caller":"etcdserver/raft.go:387","msg":"leader failed to send out heartbeat on time; took too long, leader is overloaded likely from slow disk","to":"dd742632527f2650","heartbeat-interval":"100ms","expected-duration":"200ms","exceeded-duration":"46.932574ms"} {"level":"info","ts":"2026-04-18T17:55:48.649374Z","caller":"traceutil/trace.go:172","msg":"trace[2072924816] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"280.070205ms","start":"2026-04-18T17:55:48.369048Z","end":"2026-04-18T17:55:48.649118Z","steps":["trace[2072924816] 'process raft request' (duration: 279.848453ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:55:48.649370Z","caller":"traceutil/trace.go:172","msg":"trace[1209658739] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"276.327738ms","start":"2026-04-18T17:55:48.373021Z","end":"2026-04-18T17:55:48.649349Z","steps":["trace[1209658739] 'process raft request' (duration: 276.098266ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:55:48.654164Z","caller":"traceutil/trace.go:172","msg":"trace[1937137624] linearizableReadLoop","detail":"{readStateIndex:1084; appliedIndex:1088; }","duration":"252.247385ms","start":"2026-04-18T17:55:48.401899Z","end":"2026-04-18T17:55:48.654147Z","steps":["trace[1937137624] 'read index received' (duration: 252.240895ms)","trace[1937137624] 'applied index is now lower than readState.Index' (duration: 5.79µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:55:48.654313Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"407.15982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:55:48.654354Z","caller":"traceutil/trace.go:172","msg":"trace[1754898425] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:967; }","duration":"407.215021ms","start":"2026-04-18T17:55:48.247127Z","end":"2026-04-18T17:55:48.654343Z","steps":["trace[1754898425] 'agreement among raft nodes before linearized reading' (duration: 407.12547ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:48.654384Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:48.247099Z","time spent":"407.275782ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":103,"response count":0,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:55:48.654413Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"456.747493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:55:48.654485Z","caller":"traceutil/trace.go:172","msg":"trace[10503307] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:967; }","duration":"456.818004ms","start":"2026-04-18T17:55:48.197654Z","end":"2026-04-18T17:55:48.654472Z","steps":["trace[10503307] 'agreement among raft nodes before linearized reading' (duration: 456.717623ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:48.654516Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:48.197642Z","time spent":"456.867194ms","remote":"127.0.0.1:40032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-18T17:55:48.788123Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"335.560955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" limit:1 ","response":"range_response_count:1 size:4333"} {"level":"info","ts":"2026-04-18T17:55:48.788231Z","caller":"traceutil/trace.go:172","msg":"trace[1718902114] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:1; response_revision:967; }","duration":"335.683776ms","start":"2026-04-18T17:55:48.452521Z","end":"2026-04-18T17:55:48.788205Z","steps":["trace[1718902114] 'agreement among raft nodes before linearized reading' (duration: 274.735673ms)","trace[1718902114] 'range keys from in-memory index tree' (duration: 60.682581ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:55:48.788251Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"324.676628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-04-18T17:55:48.788280Z","caller":"traceutil/trace.go:172","msg":"trace[1437744117] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:967; }","duration":"324.702879ms","start":"2026-04-18T17:55:48.463567Z","end":"2026-04-18T17:55:48.788270Z","steps":["trace[1437744117] 'agreement among raft nodes before linearized reading' (duration: 263.675265ms)","trace[1437744117] 'range keys from in-memory index tree' (duration: 60.942573ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:55:48.788280Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:48.452478Z","time spent":"335.792277ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":1,"response size":4357,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:55:48.788301Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:48.463545Z","time spent":"324.7501ms","remote":"127.0.0.1:40578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":519,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 "} {"level":"info","ts":"2026-04-18T17:55:48.788348Z","caller":"traceutil/trace.go:172","msg":"trace[814976258] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"132.271056ms","start":"2026-04-18T17:55:48.656049Z","end":"2026-04-18T17:55:48.788320Z","steps":["trace[814976258] 'process raft request' (duration: 71.126921ms)","trace[814976258] 'compare' (duration: 60.938503ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:55:48.788123Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"140.611157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" limit:1 ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-04-18T17:55:48.788544Z","caller":"traceutil/trace.go:172","msg":"trace[1966363004] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:967; }","duration":"141.059791ms","start":"2026-04-18T17:55:48.647473Z","end":"2026-04-18T17:55:48.788532Z","steps":["trace[1966363004] 'agreement among raft nodes before linearized reading' (duration: 79.753295ms)","trace[1966363004] 'range keys from in-memory index tree' (duration: 60.64394ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T17:55:48.789803Z","caller":"traceutil/trace.go:172","msg":"trace[1010767863] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"126.098576ms","start":"2026-04-18T17:55:48.663687Z","end":"2026-04-18T17:55:48.789786Z","steps":["trace[1010767863] 'process raft request' (duration: 125.883254ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:48.790731Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"135.315747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:55:48.790804Z","caller":"traceutil/trace.go:172","msg":"trace[1275576819] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:969; }","duration":"135.389477ms","start":"2026-04-18T17:55:48.655406Z","end":"2026-04-18T17:55:48.790795Z","steps":["trace[1275576819] 'agreement among raft nodes before linearized reading' (duration: 135.283876ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:51.529439Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47246","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:55:51.543707Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47256","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:55:51.630022Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47270","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:55:51.671983Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47292","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:55:51.715255Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47306","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:55:51.831714Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47338","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:55:56.108155Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39086","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:55:59.572774Z","caller":"etcdserver/raft.go:387","msg":"leader failed to send out heartbeat on time; took too long, leader is overloaded likely from slow disk","to":"dd742632527f2650","heartbeat-interval":"100ms","expected-duration":"200ms","exceeded-duration":"114.466936ms"} {"level":"info","ts":"2026-04-18T17:55:59.981739Z","caller":"traceutil/trace.go:172","msg":"trace[1657604399] linearizableReadLoop","detail":"{readStateIndex:1193; appliedIndex:1194; }","duration":"330.592751ms","start":"2026-04-18T17:55:59.651116Z","end":"2026-04-18T17:55:59.981709Z","steps":["trace[1657604399] 'read index received' (duration: 330.582011ms)","trace[1657604399] 'applied index is now lower than readState.Index' (duration: 9.31µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:55:59.981658Z","caller":"etcdserver/raft.go:387","msg":"leader failed to send out heartbeat on time; took too long, leader is overloaded likely from slow disk","to":"dd742632527f2650","heartbeat-interval":"100ms","expected-duration":"200ms","exceeded-duration":"85.755587ms"} {"level":"warn","ts":"2026-04-18T17:55:59.982199Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"331.059406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:55:59.982280Z","caller":"traceutil/trace.go:172","msg":"trace[1580457657] range","detail":"{range_begin:/registry/jobs; range_end:; response_count:0; response_revision:1059; }","duration":"331.170577ms","start":"2026-04-18T17:55:59.651094Z","end":"2026-04-18T17:55:59.982264Z","steps":["trace[1580457657] 'agreement among raft nodes before linearized reading' (duration: 330.692693ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:59.982323Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:55:59.651059Z","time spent":"331.255208ms","remote":"127.0.0.1:40528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/jobs\" limit:1 "} {"level":"info","ts":"2026-04-18T17:55:59.985724Z","caller":"traceutil/trace.go:172","msg":"trace[916812408] transaction","detail":"{read_only:false; response_revision:1062; number_of_response:1; }","duration":"161.11275ms","start":"2026-04-18T17:55:59.824585Z","end":"2026-04-18T17:55:59.985697Z","steps":["trace[916812408] 'process raft request' (duration: 161.04621ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:55:59.986297Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"270.376277ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:55:59.986351Z","caller":"traceutil/trace.go:172","msg":"trace[1269976069] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1062; }","duration":"270.446668ms","start":"2026-04-18T17:55:59.715890Z","end":"2026-04-18T17:55:59.986337Z","steps":["trace[1269976069] 'agreement among raft nodes before linearized reading' (duration: 270.280867ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:56:07.408407Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58970","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:56:07.431668Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58976","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:56:07.442908Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:58992","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-18T17:56:07.457347Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:59010","server-name":"","error":"EOF"} {"level":"info","ts":"2026-04-18T17:56:22.407410Z","caller":"traceutil/trace.go:172","msg":"trace[648837487] linearizableReadLoop","detail":"{readStateIndex:1356; appliedIndex:1356; }","duration":"162.801833ms","start":"2026-04-18T17:56:22.244570Z","end":"2026-04-18T17:56:22.407372Z","steps":["trace[648837487] 'read index received' (duration: 162.794113ms)","trace[648837487] 'applied index is now lower than readState.Index' (duration: 6.08µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:56:22.470014Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"225.409455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" limit:1 ","response":"range_response_count:1 size:840"} {"level":"info","ts":"2026-04-18T17:56:22.470139Z","caller":"traceutil/trace.go:172","msg":"trace[2133568649] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:1; response_revision:1210; }","duration":"225.549586ms","start":"2026-04-18T17:56:22.244565Z","end":"2026-04-18T17:56:22.470115Z","steps":["trace[2133568649] 'agreement among raft nodes before linearized reading' (duration: 162.925784ms)","trace[2133568649] 'range keys from in-memory index tree' (duration: 62.254168ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:56:22.470154Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"209.484842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-edit\" limit:1 ","response":"range_response_count:1 size:2133"} {"level":"info","ts":"2026-04-18T17:56:22.470222Z","caller":"traceutil/trace.go:172","msg":"trace[328590292] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-edit; range_end:; response_count:1; response_revision:1211; }","duration":"209.565073ms","start":"2026-04-18T17:56:22.260644Z","end":"2026-04-18T17:56:22.470209Z","steps":["trace[328590292] 'agreement among raft nodes before linearized reading' (duration: 209.377171ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:56:22.470228Z","caller":"traceutil/trace.go:172","msg":"trace[2025784619] transaction","detail":"{read_only:false; response_revision:1211; number_of_response:1; }","duration":"236.753944ms","start":"2026-04-18T17:56:22.233457Z","end":"2026-04-18T17:56:22.470211Z","steps":["trace[2025784619] 'process raft request' (duration: 172.825859ms)","trace[2025784619] 'compare' (duration: 63.366319ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:56:22.470168Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"166.033924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-view\" limit:1 ","response":"range_response_count:1 size:2030"} {"level":"info","ts":"2026-04-18T17:56:22.470387Z","caller":"traceutil/trace.go:172","msg":"trace[1295482271] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-view; range_end:; response_count:1; response_revision:1211; }","duration":"166.261036ms","start":"2026-04-18T17:56:22.304120Z","end":"2026-04-18T17:56:22.470381Z","steps":["trace[1295482271] 'agreement among raft nodes before linearized reading' (duration: 165.938333ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:56:22.470432Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"169.475827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:auth-delegator\" limit:1 ","response":"range_response_count:1 size:651"} {"level":"info","ts":"2026-04-18T17:56:22.470501Z","caller":"traceutil/trace.go:172","msg":"trace[268958808] range","detail":"{range_begin:/registry/clusterroles/system:auth-delegator; range_end:; response_count:1; response_revision:1211; }","duration":"169.78715ms","start":"2026-04-18T17:56:22.300694Z","end":"2026-04-18T17:56:22.470481Z","steps":["trace[268958808] 'agreement among raft nodes before linearized reading' (duration: 169.402067ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:56:43.186309Z","caller":"etcdserver/raft.go:387","msg":"leader failed to send out heartbeat on time; took too long, leader is overloaded likely from slow disk","to":"dd742632527f2650","heartbeat-interval":"100ms","expected-duration":"200ms","exceeded-duration":"44.8971ms"} {"level":"info","ts":"2026-04-18T17:56:43.186963Z","caller":"traceutil/trace.go:172","msg":"trace[1614948755] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"236.853181ms","start":"2026-04-18T17:56:42.950051Z","end":"2026-04-18T17:56:43.186905Z","steps":["trace[1614948755] 'process raft request' (duration: 236.584169ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:56:43.325309Z","caller":"traceutil/trace.go:172","msg":"trace[1534128541] linearizableReadLoop","detail":"{readStateIndex:1447; appliedIndex:1448; }","duration":"374.733724ms","start":"2026-04-18T17:56:42.950558Z","end":"2026-04-18T17:56:43.325291Z","steps":["trace[1534128541] 'read index received' (duration: 374.729194ms)","trace[1534128541] 'applied index is now lower than readState.Index' (duration: 3.75µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:56:43.510071Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"559.494571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-controller-2\" limit:1 ","response":"range_response_count:1 size:4822"} {"level":"info","ts":"2026-04-18T17:56:43.510144Z","caller":"traceutil/trace.go:172","msg":"trace[843189800] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-controller-2; range_end:; response_count:1; response_revision:1294; }","duration":"559.572625ms","start":"2026-04-18T17:56:42.950545Z","end":"2026-04-18T17:56:43.510118Z","steps":["trace[843189800] 'agreement among raft nodes before linearized reading' (duration: 374.961034ms)","trace[843189800] 'range keys from in-memory index tree' (duration: 184.427493ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:56:43.510140Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"184.79789ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"warn","ts":"2026-04-18T17:56:43.510191Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:56:42.950536Z","time spent":"559.640669ms","remote":"127.0.0.1:40436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":4846,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-controller-2\" limit:1 "} {"level":"info","ts":"2026-04-18T17:56:43.510466Z","caller":"traceutil/trace.go:172","msg":"trace[1781455240] linearizableReadLoop","detail":"{readStateIndex:1450; appliedIndex:1448; }","duration":"184.837101ms","start":"2026-04-18T17:56:43.325609Z","end":"2026-04-18T17:56:43.510446Z","steps":["trace[1781455240] 'read index received' (duration: 80.989877ms)","trace[1781455240] 'applied index is now lower than readState.Index' (duration: 103.844664ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T17:56:43.512970Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"313.570016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T17:56:43.513023Z","caller":"traceutil/trace.go:172","msg":"trace[453553440] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1296; }","duration":"313.627419ms","start":"2026-04-18T17:56:43.199383Z","end":"2026-04-18T17:56:43.513011Z","steps":["trace[453553440] 'agreement among raft nodes before linearized reading' (duration: 311.219726ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:56:43.513055Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:56:43.199359Z","time spent":"313.688092ms","remote":"127.0.0.1:40032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-18T17:56:43.513067Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"490.873797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/kubeadm:kubelet-config\" limit:1 ","response":"range_response_count:1 size:538"} {"level":"info","ts":"2026-04-18T17:56:43.513203Z","caller":"traceutil/trace.go:172","msg":"trace[2047516433] range","detail":"{range_begin:/registry/rolebindings/kube-system/kubeadm:kubelet-config; range_end:; response_count:1; response_revision:1296; }","duration":"490.94228ms","start":"2026-04-18T17:56:43.022172Z","end":"2026-04-18T17:56:43.513114Z","steps":["trace[2047516433] 'agreement among raft nodes before linearized reading' (duration: 488.445443ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:56:43.513295Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:56:43.022154Z","time spent":"491.125528ms","remote":"127.0.0.1:40746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":562,"request content":"key:\"/registry/rolebindings/kube-system/kubeadm:kubelet-config\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:56:43.513332Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"254.545044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-04-18T17:56:43.513392Z","caller":"traceutil/trace.go:172","msg":"trace[1499184085] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1296; }","duration":"254.611937ms","start":"2026-04-18T17:56:43.258767Z","end":"2026-04-18T17:56:43.513379Z","steps":["trace[1499184085] 'agreement among raft nodes before linearized reading' (duration: 251.824067ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:56:43.513354Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"194.585267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T17:56:43.513520Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"368.724019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-18T17:56:43.513554Z","caller":"traceutil/trace.go:172","msg":"trace[1022406131] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1296; }","duration":"368.754781ms","start":"2026-04-18T17:56:43.144790Z","end":"2026-04-18T17:56:43.513544Z","steps":["trace[1022406131] 'agreement among raft nodes before linearized reading' (duration: 365.692408ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:56:43.513579Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:56:43.144775Z","time spent":"368.797233ms","remote":"127.0.0.1:40578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:56:43.513632Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"527.615016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/kubeadm:kubeadm-certs\" limit:1 ","response":"range_response_count:1 size:483"} {"level":"info","ts":"2026-04-18T17:56:43.514000Z","caller":"traceutil/trace.go:172","msg":"trace[294529345] range","detail":"{range_begin:/registry/rolebindings/kube-system/kubeadm:kubeadm-certs; range_end:; response_count:1; response_revision:1296; }","duration":"528.341009ms","start":"2026-04-18T17:56:42.985644Z","end":"2026-04-18T17:56:43.513986Z","steps":["trace[294529345] 'agreement among raft nodes before linearized reading' (duration: 525.082827ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:56:43.514528Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:56:42.985613Z","time spent":"528.887404ms","remote":"127.0.0.1:40746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":507,"request content":"key:\"/registry/rolebindings/kube-system/kubeadm:kubeadm-certs\" limit:1 "} {"level":"info","ts":"2026-04-18T17:56:43.513527Z","caller":"traceutil/trace.go:172","msg":"trace[1588890935] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes; range_end:; response_count:0; response_revision:1296; }","duration":"195.103251ms","start":"2026-04-18T17:56:43.318406Z","end":"2026-04-18T17:56:43.513509Z","steps":["trace[1588890935] 'agreement among raft nodes before linearized reading' (duration: 192.169314ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:56:43.513443Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"520.311684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-controller-1\" limit:1 ","response":"range_response_count:1 size:4857"} {"level":"warn","ts":"2026-04-18T17:56:43.513797Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"376.221589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-04-18T17:56:43.515034Z","caller":"traceutil/trace.go:172","msg":"trace[1623224377] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1296; }","duration":"377.455306ms","start":"2026-04-18T17:56:43.137562Z","end":"2026-04-18T17:56:43.515017Z","steps":["trace[1623224377] 'agreement among raft nodes before linearized reading' (duration: 373.068082ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T17:56:43.514952Z","caller":"traceutil/trace.go:172","msg":"trace[1677133824] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-controller-1; range_end:; response_count:1; response_revision:1296; }","duration":"521.804223ms","start":"2026-04-18T17:56:42.993120Z","end":"2026-04-18T17:56:43.514924Z","steps":["trace[1677133824] 'agreement among raft nodes before linearized reading' (duration: 517.544844ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T17:56:43.515100Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:56:43.137547Z","time spent":"377.528351ms","remote":"127.0.0.1:40578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":465,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 "} {"level":"warn","ts":"2026-04-18T17:56:43.515145Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-18T17:56:42.993102Z","time spent":"522.012653ms","remote":"127.0.0.1:40436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4881,"request content":"key:\"/registry/pods/kube-system/kube-vip-controller-1\" limit:1 "}