{"level":"warn","ts":"2026-04-22T09:34:31.490690Z","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-22T09:34:31.490809Z","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-22T09:34:31.490828Z","caller":"etcdmain/etcd.go:64","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.143:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--feature-gates=InitialCorruptCheck=true","--initial-advertise-peer-urls=https://199.19.213.143:2380","--initial-cluster=controller-2=https://199.19.213.143:2380,controller-1=https://199.19.213.105:2380","--initial-cluster-state=existing","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.143:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.143:2380","--name=controller-2","--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-22T09:34:31.490950Z","caller":"etcdmain/etcd.go:124","msg":"Initialize and start etcd server","data-dir":"/var/lib/etcd","dir-type":"empty"} {"level":"warn","ts":"2026-04-22T09:34:31.490977Z","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-22T09:34:31.490991Z","caller":"embed/etcd.go:138","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.143:2380"]} {"level":"info","ts":"2026-04-22T09:34:31.491008Z","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-22T09:34:31.491515Z","caller":"embed/etcd.go:146","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.143:2379"]} {"level":"info","ts":"2026-04-22T09:34:31.491687Z","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-2","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.143:2380"],"listen-peer-urls":["https://199.19.213.143:2380"],"advertise-client-urls":["https://199.19.213.143:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.143:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"experimental-local-address":"","cors":["*"],"host-whitelist":["*"],"initial-cluster":"controller-1=https://199.19.213.105:2380,controller-2=https://199.19.213.143:2380","initial-cluster-state":"existing","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-22T09:34:31.493126Z","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: 0xc0001371f0}"} {"level":"info","ts":"2026-04-22T09:34:31.499092Z","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-22T09:34:31.499194Z","caller":"storage/backend.go:80","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.196226ms"} {"level":"info","ts":"2026-04-22T09:34:31.499273Z","caller":"etcdserver/bootstrap.go:220","msg":"restore consistentIndex","index":0} {"level":"info","ts":"2026-04-22T09:34:31.499285Z","caller":"etcdserver/bootstrap.go:94","msg":"bootstrapping cluster"} {"level":"info","ts":"2026-04-22T09:34:31.509462Z","caller":"netutil/netutil.go:113","msg":"resolved URL Host","url":"https://199.19.213.105:2380","host":"199.19.213.105:2380","resolved-addr":"199.19.213.105:2380"} {"level":"info","ts":"2026-04-22T09:34:31.509503Z","caller":"netutil/netutil.go:113","msg":"resolved URL Host","url":"https://199.19.213.143:2380","host":"199.19.213.143:2380","resolved-addr":"199.19.213.143:2380"} {"level":"info","ts":"2026-04-22T09:34:31.856036Z","caller":"etcdserver/bootstrap.go:101","msg":"bootstrapping storage"} {"level":"info","ts":"2026-04-22T09:34:31.913825Z","caller":"etcdserver/bootstrap.go:109","msg":"bootstrapping raft"} {"level":"info","ts":"2026-04-22T09:34:31.913916Z","caller":"etcdserver/bootstrap.go:499","msg":"starting local member","local-member-id":"b96a40f6a27ea58b","cluster-id":"f43476f3367c14fb"} {"level":"info","ts":"2026-04-22T09:34:31.913986Z","caller":"etcdserver/server.go:312","msg":"bootstrap successfully"} {"level":"info","ts":"2026-04-22T09:34:31.914130Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"b96a40f6a27ea58b switched to configuration voters=()"} {"level":"info","ts":"2026-04-22T09:34:31.914203Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"b96a40f6a27ea58b became follower at term 0"} {"level":"info","ts":"2026-04-22T09:34:31.914226Z","logger":"raft","caller":"v3@v3.6.0/raft.go:493","msg":"newRaft b96a40f6a27ea58b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"warn","ts":"2026-04-22T09:34:31.928741Z","caller":"auth/store.go:1135","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-22T09:34:31.937440Z","caller":"mvcc/kvstore.go:408","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-22T09:34:31.941351Z","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-22T09:34:31.942293Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"eb6db91b2c71522f"} {"level":"info","ts":"2026-04-22T09:34:31.942384Z","caller":"rafthttp/transport.go:286","msg":"added new remote peer","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"eb6db91b2c71522f","remote-peer-urls":["https://199.19.213.105:2380"]} {"level":"info","ts":"2026-04-22T09:34:31.942450Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"eb6db91b2c71522f"} {"level":"info","ts":"2026-04-22T09:34:31.942515Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"eb6db91b2c71522f"} {"level":"info","ts":"2026-04-22T09:34:31.944536Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"eb6db91b2c71522f"} {"level":"info","ts":"2026-04-22T09:34:31.947076Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"eb6db91b2c71522f"} {"level":"info","ts":"2026-04-22T09:34:31.947137Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"eb6db91b2c71522f","remote-peer-urls":["https://199.19.213.105:2380"]} {"level":"info","ts":"2026-04-22T09:34:31.947178Z","caller":"etcdserver/server.go:598","msg":"starting etcd server","local-member-id":"b96a40f6a27ea58b","local-server-version":"3.6.4","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-22T09:34:31.947392Z","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-22T09:34:31.947751Z","caller":"embed/etcd.go:292","msg":"now serving peer/client/metrics","local-member-id":"b96a40f6a27ea58b","initial-advertise-peer-urls":["https://199.19.213.143:2380"],"listen-peer-urls":["https://199.19.213.143:2380"],"advertise-client-urls":["https://199.19.213.143:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.143:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-22T09:34:31.947790Z","caller":"embed/etcd.go:890","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-22T09:34:31.947851Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"eb6db91b2c71522f"} {"level":"info","ts":"2026-04-22T09:34:31.947885Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"eb6db91b2c71522f"} {"level":"info","ts":"2026-04-22T09:34:31.948117Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"eb6db91b2c71522f"} {"level":"info","ts":"2026-04-22T09:34:31.948321Z","caller":"etcdserver/server.go:499","msg":"starting initial election tick advance","election-ticks":10} {"level":"info","ts":"2026-04-22T09:34:31.948367Z","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-22T09:34:31.948728Z","caller":"embed/etcd.go:640","msg":"serving peer traffic","address":"199.19.213.143:2380"} {"level":"info","ts":"2026-04-22T09:34:31.948765Z","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-22T09:34:31.948805Z","caller":"embed/etcd.go:611","msg":"cmux::serve","address":"199.19.213.143:2380"} {"level":"info","ts":"2026-04-22T09:34:31.948835Z","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-22T09:34:31.949286Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1116","msg":"b96a40f6a27ea58b [term: 0] received a MsgHeartbeat message with higher term from eb6db91b2c71522f [term: 2]"} {"level":"info","ts":"2026-04-22T09:34:31.949310Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"b96a40f6a27ea58b became follower at term 2"} {"level":"info","ts":"2026-04-22T09:34:31.949353Z","logger":"raft","caller":"v3@v3.6.0/node.go:370","msg":"raft.node: b96a40f6a27ea58b elected leader eb6db91b2c71522f at term 2"} {"level":"info","ts":"2026-04-22T09:34:31.949379Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"b96a40f6a27ea58b","to":"eb6db91b2c71522f","stream-type":"stream Message"} {"level":"info","ts":"2026-04-22T09:34:31.949432Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"eb6db91b2c71522f"} {"level":"info","ts":"2026-04-22T09:34:31.949489Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"eb6db91b2c71522f"} {"level":"info","ts":"2026-04-22T09:34:31.951374Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"b96a40f6a27ea58b","to":"eb6db91b2c71522f","stream-type":"stream MsgApp v2"} {"level":"info","ts":"2026-04-22T09:34:31.951422Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"eb6db91b2c71522f"} {"level":"info","ts":"2026-04-22T09:34:31.961139Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"eb6db91b2c71522f"} {"level":"info","ts":"2026-04-22T09:34:31.963082Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"eb6db91b2c71522f"} {"level":"info","ts":"2026-04-22T09:34:32.345374Z","caller":"rafthttp/http.go:258","msg":"receiving database snapshot","local-member-id":"b96a40f6a27ea58b","remote-snapshot-sender-id":"eb6db91b2c71522f","incoming-snapshot-index":574,"incoming-snapshot-message-size-bytes":8203,"incoming-snapshot-message-size":"8.2 kB"} {"level":"info","ts":"2026-04-22T09:34:32.358540Z","caller":"snap/db.go:65","msg":"saved database snapshot to disk","path":"/var/lib/etcd/member/snap/000000000000023e.snap.db","bytes":913408,"size":"913 kB"} {"level":"info","ts":"2026-04-22T09:34:32.358636Z","caller":"rafthttp/http.go:287","msg":"received and saved database snapshot","local-member-id":"b96a40f6a27ea58b","remote-snapshot-sender-id":"eb6db91b2c71522f","incoming-snapshot-index":574,"incoming-snapshot-size-bytes":913408,"incoming-snapshot-size":"913 kB","download-took":"13.329759ms"} {"level":"info","ts":"2026-04-22T09:34:32.358780Z","logger":"raft","caller":"v3@v3.6.0/log.go:465","msg":"log [committed=0, applied=0, applying=0, unstable.offset=1, unstable.offsetInProgress=1, len(unstable.Entries)=0] starts to restore snapshot [index: 574, term: 2]"} {"level":"info","ts":"2026-04-22T09:34:32.358850Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"b96a40f6a27ea58b switched to configuration voters=(16964418897735406127) learners=(13360562672580339083)"} {"level":"info","ts":"2026-04-22T09:34:32.358868Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1935","msg":"b96a40f6a27ea58b [commit: 574, lastindex: 574, lastterm: 2] restored snapshot [index: 574, term: 2]"} {"level":"info","ts":"2026-04-22T09:34:32.358875Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1844","msg":"b96a40f6a27ea58b [commit: 574] restored snapshot [index: 574, term: 2]"} {"level":"info","ts":"2026-04-22T09:34:32.358935Z","caller":"etcdserver/server.go:1007","msg":"applying snapshot","current-snapshot-index":0,"current-applied-index":0,"incoming-leader-snapshot-index":574,"incoming-leader-snapshot-term":2} {"level":"info","ts":"2026-04-22T09:34:32.362181Z","caller":"etcdserver/raft.go:276","msg":"applied incoming Raft snapshot","snapshot-index":574} {"level":"info","ts":"2026-04-22T09:34:32.362355Z","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: 0xc00039c240}"} {"level":"info","ts":"2026-04-22T09:34:32.362713Z","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-22T09:34:32.362736Z","caller":"storage/backend.go:80","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"418.309µs"} {"level":"info","ts":"2026-04-22T09:34:32.362771Z","caller":"etcdserver/server.go:1055","msg":"restoring lease store"} {"level":"info","ts":"2026-04-22T09:34:32.365190Z","caller":"etcdserver/server.go:1059","msg":"restored lease store"} {"level":"info","ts":"2026-04-22T09:34:32.365207Z","caller":"etcdserver/server.go:1062","msg":"restoring mvcc store"} {"level":"info","ts":"2026-04-22T09:34:32.367419Z","caller":"mvcc/kvstore.go:408","msg":"kvstore restored","current-rev":541} {"level":"info","ts":"2026-04-22T09:34:32.367525Z","caller":"etcdserver/server.go:1070","msg":"restored mvcc store","consistent-index":574} {"level":"info","ts":"2026-04-22T09:34:32.367620Z","caller":"etcdserver/server.go:1078","msg":"closing old backend file"} {"level":"info","ts":"2026-04-22T09:34:32.367808Z","caller":"etcdserver/server.go:1090","msg":"restoring alarm store"} {"level":"info","ts":"2026-04-22T09:34:32.369777Z","caller":"etcdserver/server.go:1096","msg":"restored alarm store"} {"level":"info","ts":"2026-04-22T09:34:32.369886Z","caller":"etcdserver/server.go:1099","msg":"restoring auth store"} {"level":"info","ts":"2026-04-22T09:34:32.369948Z","caller":"etcdserver/server.go:1103","msg":"restored auth store"} {"level":"info","ts":"2026-04-22T09:34:32.369964Z","caller":"etcdserver/server.go:1106","msg":"restoring v2 store"} {"level":"info","ts":"2026-04-22T09:34:32.370187Z","caller":"etcdserver/server.go:1080","msg":"closed old backend file"} {"level":"info","ts":"2026-04-22T09:34:32.370724Z","caller":"etcdserver/server.go:1115","msg":"restored v2 store"} {"level":"info","ts":"2026-04-22T09:34:32.370754Z","caller":"etcdserver/server.go:1119","msg":"restoring cluster configuration"} {"level":"info","ts":"2026-04-22T09:34:32.370809Z","caller":"api/capability.go:76","msg":"enabled capabilities for version","cluster-version":"3.6"} {"level":"info","ts":"2026-04-22T09:34:32.370826Z","caller":"membership/cluster.go:297","msg":"recovered/added member from store","cluster-id":"f43476f3367c14fb","local-member-id":"b96a40f6a27ea58b","recovered-remote-peer-id":"eb6db91b2c71522f","recovered-remote-peer-urls":["https://199.19.213.105:2380"],"recovered-remote-peer-is-learner":false} {"level":"info","ts":"2026-04-22T09:34:32.370837Z","caller":"membership/cluster.go:297","msg":"recovered/added member from store","cluster-id":"f43476f3367c14fb","local-member-id":"b96a40f6a27ea58b","recovered-remote-peer-id":"b96a40f6a27ea58b","recovered-remote-peer-urls":["https://199.19.213.143:2380"],"recovered-remote-peer-is-learner":true} {"level":"info","ts":"2026-04-22T09:34:32.370845Z","caller":"membership/cluster.go:307","msg":"set cluster version from store","cluster-version":"3.6"} {"level":"info","ts":"2026-04-22T09:34:32.370851Z","caller":"etcdserver/server.go:1123","msg":"restored cluster configuration"} {"level":"info","ts":"2026-04-22T09:34:32.370864Z","caller":"etcdserver/server.go:1124","msg":"removing old peers from network"} {"level":"info","ts":"2026-04-22T09:34:32.370874Z","caller":"rafthttp/peer.go:316","msg":"stopping remote peer","remote-peer-id":"eb6db91b2c71522f"} {"level":"warn","ts":"2026-04-22T09:34:32.370935Z","caller":"rafthttp/stream.go:285","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"eb6db91b2c71522f"} {"level":"info","ts":"2026-04-22T09:34:32.370957Z","caller":"rafthttp/stream.go:293","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"eb6db91b2c71522f"} {"level":"warn","ts":"2026-04-22T09:34:32.370994Z","caller":"rafthttp/stream.go:285","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"eb6db91b2c71522f"} {"level":"info","ts":"2026-04-22T09:34:32.371008Z","caller":"rafthttp/stream.go:293","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"eb6db91b2c71522f"} {"level":"info","ts":"2026-04-22T09:34:32.371164Z","caller":"rafthttp/pipeline.go:85","msg":"stopped HTTP pipelining with remote peer","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"eb6db91b2c71522f"} {"level":"warn","ts":"2026-04-22T09:34:32.371281Z","caller":"rafthttp/stream.go:420","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"eb6db91b2c71522f","error":"context canceled"} {"level":"warn","ts":"2026-04-22T09:34:32.371318Z","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"eb6db91b2c71522f","error":"failed to read eb6db91b2c71522f on stream MsgApp v2 (context canceled)"} {"level":"info","ts":"2026-04-22T09:34:32.371334Z","caller":"rafthttp/stream.go:441","msg":"stopped stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"eb6db91b2c71522f"} {"level":"warn","ts":"2026-04-22T09:34:32.371404Z","caller":"rafthttp/stream.go:420","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"eb6db91b2c71522f","error":"context canceled"} {"level":"info","ts":"2026-04-22T09:34:32.371427Z","caller":"rafthttp/stream.go:441","msg":"stopped stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"eb6db91b2c71522f"} {"level":"info","ts":"2026-04-22T09:34:32.371434Z","caller":"rafthttp/peer.go:321","msg":"stopped remote peer","remote-peer-id":"eb6db91b2c71522f"} {"level":"info","ts":"2026-04-22T09:34:32.371526Z","caller":"rafthttp/transport.go:354","msg":"removed remote peer","local-member-id":"b96a40f6a27ea58b","removed-remote-peer-id":"eb6db91b2c71522f"} {"level":"info","ts":"2026-04-22T09:34:32.371541Z","caller":"etcdserver/server.go:1129","msg":"removed old peers from network"} {"level":"info","ts":"2026-04-22T09:34:32.371550Z","caller":"etcdserver/server.go:1130","msg":"adding peers from new cluster configuration"} {"level":"info","ts":"2026-04-22T09:34:32.371567Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"eb6db91b2c71522f"} {"level":"info","ts":"2026-04-22T09:34:32.371586Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"eb6db91b2c71522f"} {"level":"info","ts":"2026-04-22T09:34:32.372362Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"eb6db91b2c71522f"} {"level":"info","ts":"2026-04-22T09:34:32.372461Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"eb6db91b2c71522f","remote-peer-urls":["https://199.19.213.105:2380"]} {"level":"info","ts":"2026-04-22T09:34:32.372497Z","caller":"etcdserver/server.go:1139","msg":"added peers from new cluster configuration"} {"level":"info","ts":"2026-04-22T09:34:32.372537Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"eb6db91b2c71522f"} {"level":"info","ts":"2026-04-22T09:34:32.372538Z","caller":"etcdserver/server.go:1015","msg":"applied snapshot","current-snapshot-index":574,"current-applied-index":574,"incoming-leader-snapshot-index":574,"incoming-leader-snapshot-term":2} {"level":"info","ts":"2026-04-22T09:34:32.372521Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"eb6db91b2c71522f"} {"level":"info","ts":"2026-04-22T09:34:32.372493Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"eb6db91b2c71522f"} {"level":"info","ts":"2026-04-22T09:34:32.372601Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"eb6db91b2c71522f"} {"level":"info","ts":"2026-04-22T09:34:32.381480Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"b96a40f6a27ea58b","to":"eb6db91b2c71522f","stream-type":"stream MsgApp v2"} {"level":"info","ts":"2026-04-22T09:34:32.381533Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"eb6db91b2c71522f"} {"level":"info","ts":"2026-04-22T09:34:32.381569Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"eb6db91b2c71522f"} {"level":"info","ts":"2026-04-22T09:34:32.381872Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"eb6db91b2c71522f"} {"level":"info","ts":"2026-04-22T09:34:32.382070Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"b96a40f6a27ea58b","to":"eb6db91b2c71522f","stream-type":"stream Message"} {"level":"info","ts":"2026-04-22T09:34:32.382158Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"eb6db91b2c71522f"} {"level":"info","ts":"2026-04-22T09:34:32.418527Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"eb6db91b2c71522f"} {"level":"info","ts":"2026-04-22T09:34:32.610787Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"b96a40f6a27ea58b switched to configuration voters=(13360562672580339083 16964418897735406127)"} {"level":"info","ts":"2026-04-22T09:34:32.611126Z","caller":"membership/cluster.go:550","msg":"promote member","cluster-id":"f43476f3367c14fb","local-member-id":"b96a40f6a27ea58b","promoted-member-id":"b96a40f6a27ea58b"} {"level":"warn","ts":"2026-04-22T09:34:38.949153Z","caller":"etcdserver/server.go:1814","msg":"failed to publish local member to cluster through raft","local-member-id":"b96a40f6a27ea58b","local-member-attributes":"{Name:controller-2 ClientURLs:[https://199.19.213.143:2379]}","publish-timeout":"7s","error":"etcdserver: request timed out, possibly due to connection lost"} {"level":"info","ts":"2026-04-22T09:34:39.242553Z","caller":"etcdserver/server.go:1804","msg":"published local member to cluster through raft","local-member-id":"b96a40f6a27ea58b","local-member-attributes":"{Name:controller-2 ClientURLs:[https://199.19.213.143:2379]}","cluster-id":"f43476f3367c14fb","publish-timeout":"7s"} {"level":"info","ts":"2026-04-22T09:34:39.242807Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T09:34:39.242991Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T09:34:39.243376Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-22T09:34:39.243550Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"warn","ts":"2026-04-22T09:34:39.245837Z","caller":"v3rpc/grpc.go:52","msg":"etcdserver: failed to register grpc metrics","error":"duplicate metrics collector registration attempted"} {"level":"info","ts":"2026-04-22T09:34:39.246077Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-04-22T09:34:39.246650Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-04-22T09:34:39.253170Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.143:2379"} {"level":"warn","ts":"2026-04-22T09:34:39.258208Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"199.19.213.143:35424","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.258347Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"199.19.213.143:60962","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.259008Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"199.19.213.143:35412","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.260164Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"199.19.213.143:35442","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.260545Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"199.19.213.143:60984","server-name":"","error":"EOF"} {"level":"info","ts":"2026-04-22T09:34:39.255421Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-22T09:34:39.262091Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"199.19.213.143:35430","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.262672Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"199.19.213.143:60974","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.262759Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:40708","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.263177Z","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-22T09:34:39.263604Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"199.19.213.143:35432","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.263743Z","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-22T09:34:39.263956Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"199.19.213.143:60956","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.264447Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"199.19.213.143:35406","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.274340Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54328","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.288285Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54376","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.305026Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54398","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.312985Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54424","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.327354Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54446","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.342550Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54470","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.352630Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54512","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.361402Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54518","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.370324Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54542","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.383762Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54544","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.391332Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54566","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.400180Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54588","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.409121Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54614","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.419702Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54634","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.431720Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54658","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.443159Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54670","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.451484Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54684","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.462124Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54700","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.472206Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54716","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.511639Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54754","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.524372Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54768","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.544425Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54822","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.555151Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54842","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.564046Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54848","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.575739Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54862","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.585903Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54892","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.596945Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54910","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.610309Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54912","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.619277Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54930","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.629495Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54948","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.637579Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:54972","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.645933Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55004","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.654879Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55014","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.688572Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55034","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.700915Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55062","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.714299Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55080","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.725820Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55086","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.737159Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55102","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.747397Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55112","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.763356Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55124","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.775485Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55142","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.796146Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55158","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.808215Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55188","server-name":"","error":"EOF"} {"level":"info","ts":"2026-04-22T09:34:39.817833Z","caller":"traceutil/trace.go:172","msg":"trace[1464402198] linearizableReadLoop","detail":"{readStateIndex:592; appliedIndex:593; }","duration":"151.351497ms","start":"2026-04-22T09:34:39.666459Z","end":"2026-04-22T09:34:39.817811Z","steps":["trace[1464402198] 'read index received' (duration: 151.346506ms)","trace[1464402198] 'applied index is now lower than readState.Index' (duration: 3.731µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T09:34:39.818119Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"151.631042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" limit:10000 ","response":"range_response_count:12 size:7968"} {"level":"info","ts":"2026-04-22T09:34:39.818209Z","caller":"traceutil/trace.go:172","msg":"trace[1893837068] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:12; response_revision:557; }","duration":"151.738154ms","start":"2026-04-22T09:34:39.666454Z","end":"2026-04-22T09:34:39.818192Z","steps":["trace[1893837068] 'agreement among raft nodes before linearized reading' (duration: 151.442508ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:34:39.819133Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55200","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.821239Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"110.727561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T09:34:39.821338Z","caller":"traceutil/trace.go:172","msg":"trace[960471252] range","detail":"{range_begin:/registry/clusterrolebindings; range_end:; response_count:0; response_revision:557; }","duration":"110.785222ms","start":"2026-04-22T09:34:39.710495Z","end":"2026-04-22T09:34:39.821280Z","steps":["trace[960471252] 'agreement among raft nodes before linearized reading' (duration: 110.70905ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:34:39.822863Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"112.642538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" limit:10000 ","response":"range_response_count:56 size:39935"} {"level":"info","ts":"2026-04-22T09:34:39.822908Z","caller":"traceutil/trace.go:172","msg":"trace[1203267815] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:56; response_revision:557; }","duration":"112.694269ms","start":"2026-04-22T09:34:39.710202Z","end":"2026-04-22T09:34:39.822897Z","steps":["trace[1203267815] 'agreement among raft nodes before linearized reading' (duration: 112.398413ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:34:39.822917Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"121.919107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" limit:10000 ","response":"range_response_count:70 size:64164"} {"level":"info","ts":"2026-04-22T09:34:39.822997Z","caller":"traceutil/trace.go:172","msg":"trace[1185934832] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:70; response_revision:557; }","duration":"122.01879ms","start":"2026-04-22T09:34:39.700964Z","end":"2026-04-22T09:34:39.822983Z","steps":["trace[1185934832] 'agreement among raft nodes before linearized reading' (duration: 121.49859ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:34:39.823226Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"122.229113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T09:34:39.823257Z","caller":"traceutil/trace.go:172","msg":"trace[587892594] range","detail":"{range_begin:/registry/clusterroles; range_end:; response_count:0; response_revision:557; }","duration":"122.259834ms","start":"2026-04-22T09:34:39.700989Z","end":"2026-04-22T09:34:39.823249Z","steps":["trace[587892594] 'agreement among raft nodes before linearized reading' (duration: 122.210303ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:34:39.823525Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"156.981836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T09:34:39.823632Z","caller":"traceutil/trace.go:172","msg":"trace[1506941647] range","detail":"{range_begin:/registry/rolebindings; range_end:; response_count:0; response_revision:557; }","duration":"157.104548ms","start":"2026-04-22T09:34:39.666509Z","end":"2026-04-22T09:34:39.823614Z","steps":["trace[1506941647] 'agreement among raft nodes before linearized reading' (duration: 156.922284ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:34:39.832429Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55228","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.841292Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55240","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.848882Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55256","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.860722Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55296","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.872639Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55306","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.888468Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55322","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.896882Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55330","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.909413Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55348","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.913893Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55370","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.960043Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55378","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.969537Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55404","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:34:39.980303Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:55420","server-name":"","error":"EOF"} {"level":"info","ts":"2026-04-22T09:34:40.793028Z","caller":"traceutil/trace.go:172","msg":"trace[1179041282] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"164.255457ms","start":"2026-04-22T09:34:40.628748Z","end":"2026-04-22T09:34:40.793004Z","steps":["trace[1179041282] 'process raft request' (duration: 164.096444ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T09:34:40.890228Z","caller":"traceutil/trace.go:172","msg":"trace[399970692] linearizableReadLoop","detail":"{readStateIndex:595; appliedIndex:596; }","duration":"257.196605ms","start":"2026-04-22T09:34:40.632951Z","end":"2026-04-22T09:34:40.890148Z","steps":["trace[399970692] 'read index received' (duration: 257.187895ms)","trace[399970692] 'applied index is now lower than readState.Index' (duration: 6.97µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T09:34:40.890407Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"257.44893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-04-22T09:34:40.890439Z","caller":"traceutil/trace.go:172","msg":"trace[2112605684] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:560; }","duration":"257.499751ms","start":"2026-04-22T09:34:40.632930Z","end":"2026-04-22T09:34:40.890430Z","steps":["trace[2112605684] 'agreement among raft nodes before linearized reading' (duration: 257.339158ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T09:35:06.822460Z","caller":"traceutil/trace.go:172","msg":"trace[750748935] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"132.404135ms","start":"2026-04-22T09:35:06.690027Z","end":"2026-04-22T09:35:06.822431Z","steps":["trace[750748935] 'process raft request' (duration: 132.15655ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T09:35:06.998775Z","caller":"traceutil/trace.go:172","msg":"trace[926025719] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"170.205854ms","start":"2026-04-22T09:35:06.828544Z","end":"2026-04-22T09:35:06.998750Z","steps":["trace[926025719] 'process raft request' (duration: 170.052241ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T09:35:07.521787Z","caller":"traceutil/trace.go:172","msg":"trace[2141929180] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"517.649538ms","start":"2026-04-22T09:35:07.004116Z","end":"2026-04-22T09:35:07.521765Z","steps":["trace[2141929180] 'process raft request' (duration: 517.485215ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:35:07.522333Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:35:07.004076Z","time spent":"517.80063ms","remote":"127.0.0.1:54432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":712,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T09:35:21.334826Z","caller":"traceutil/trace.go:172","msg":"trace[734765349] transaction","detail":"{read_only:false; response_revision:701; number_of_response:1; }","duration":"140.435786ms","start":"2026-04-22T09:35:21.194374Z","end":"2026-04-22T09:35:21.334810Z","steps":["trace[734765349] 'process raft request' (duration: 140.402845ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T09:35:21.335186Z","caller":"traceutil/trace.go:172","msg":"trace[2028567065] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"141.222949ms","start":"2026-04-22T09:35:21.193955Z","end":"2026-04-22T09:35:21.335178Z","steps":["trace[2028567065] 'process raft request' (duration: 140.65178ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:35:21.335850Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"118.891453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-04-22T09:35:21.335883Z","caller":"traceutil/trace.go:172","msg":"trace[1620424892] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:701; }","duration":"118.944534ms","start":"2026-04-22T09:35:21.216932Z","end":"2026-04-22T09:35:21.335877Z","steps":["trace[1620424892] 'agreement among raft nodes before linearized reading' (duration: 118.823892ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T09:35:21.336550Z","caller":"traceutil/trace.go:172","msg":"trace[1129396757] linearizableReadLoop","detail":"{readStateIndex:754; appliedIndex:756; }","duration":"118.70175ms","start":"2026-04-22T09:35:21.216938Z","end":"2026-04-22T09:35:21.335639Z","steps":["trace[1129396757] 'read index received' (duration: 118.69601ms)","trace[1129396757] 'applied index is now lower than readState.Index' (duration: 4.56µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T09:35:22.257535Z","caller":"traceutil/trace.go:172","msg":"trace[685115639] linearizableReadLoop","detail":"{readStateIndex:757; appliedIndex:758; }","duration":"194.738236ms","start":"2026-04-22T09:35:22.062780Z","end":"2026-04-22T09:35:22.257518Z","steps":["trace[685115639] 'read index received' (duration: 194.733946ms)","trace[685115639] 'applied index is now lower than readState.Index' (duration: 3.68µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T09:35:22.257704Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"194.908168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-22T09:35:22.257724Z","caller":"traceutil/trace.go:172","msg":"trace[271750105] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:703; }","duration":"194.942839ms","start":"2026-04-22T09:35:22.062774Z","end":"2026-04-22T09:35:22.257717Z","steps":["trace[271750105] 'agreement among raft nodes before linearized reading' (duration: 194.828967ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:35:22.259662Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"169.93374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.143\" limit:1 ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-22T09:35:22.259699Z","caller":"traceutil/trace.go:172","msg":"trace[126342178] range","detail":"{range_begin:/registry/masterleases/199.19.213.143; range_end:; response_count:1; response_revision:704; }","duration":"169.975721ms","start":"2026-04-22T09:35:22.089716Z","end":"2026-04-22T09:35:22.259692Z","steps":["trace[126342178] 'agreement among raft nodes before linearized reading' (duration: 169.857649ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:35:28.952310Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"199.19.213.133:34432","server-name":"","error":"EOF"} {"level":"info","ts":"2026-04-22T09:35:28.966548Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"b96a40f6a27ea58b switched to configuration voters=(13360562672580339083 16964418897735406127) learners=(1332073352022534722)"} {"level":"info","ts":"2026-04-22T09:35:28.966713Z","caller":"membership/cluster.go:424","msg":"added member","cluster-id":"f43476f3367c14fb","local-member-id":"b96a40f6a27ea58b","added-peer-id":"127c79a7f2112a42","added-peer-peer-urls":["https://199.19.213.133:2380"],"added-peer-is-learner":true} {"level":"info","ts":"2026-04-22T09:35:28.966757Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"127c79a7f2112a42"} {"level":"info","ts":"2026-04-22T09:35:28.966787Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"127c79a7f2112a42"} {"level":"info","ts":"2026-04-22T09:35:28.967305Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"127c79a7f2112a42"} {"level":"info","ts":"2026-04-22T09:35:28.967371Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"127c79a7f2112a42","remote-peer-urls":["https://199.19.213.133:2380"]} {"level":"info","ts":"2026-04-22T09:35:28.967410Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"127c79a7f2112a42"} {"level":"info","ts":"2026-04-22T09:35:28.967429Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"127c79a7f2112a42"} {"level":"info","ts":"2026-04-22T09:35:28.967445Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"127c79a7f2112a42"} {"level":"info","ts":"2026-04-22T09:35:28.967462Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"127c79a7f2112a42"} {"level":"info","ts":"2026-04-22T09:35:28.967532Z","caller":"etcdserver/server.go:1752","msg":"applied a configuration change through raft","local-member-id":"b96a40f6a27ea58b","raft-conf-change":"ConfChangeAddLearnerNode","raft-conf-change-node-id":"127c79a7f2112a42"} {"level":"warn","ts":"2026-04-22T09:35:28.971680Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"199.19.213.133:34460","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:35:33.024105Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"199.19.213.133:39134","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:35:33.968657Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_RAFT_MESSAGE","remote-peer-id":"127c79a7f2112a42","rtt":"0s","error":"dial tcp 199.19.213.133:2380: connect: connection refused"} {"level":"warn","ts":"2026-04-22T09:35:33.968743Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_SNAPSHOT","remote-peer-id":"127c79a7f2112a42","rtt":"0s","error":"dial tcp 199.19.213.133:2380: connect: connection refused"} {"level":"info","ts":"2026-04-22T09:35:34.094506Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"127c79a7f2112a42"} {"level":"info","ts":"2026-04-22T09:35:34.094615Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"127c79a7f2112a42"} {"level":"info","ts":"2026-04-22T09:35:34.094728Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"127c79a7f2112a42"} {"level":"info","ts":"2026-04-22T09:35:34.101754Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"b96a40f6a27ea58b","to":"127c79a7f2112a42","stream-type":"stream MsgApp v2"} {"level":"info","ts":"2026-04-22T09:35:34.101787Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"127c79a7f2112a42"} {"level":"info","ts":"2026-04-22T09:35:34.102024Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"b96a40f6a27ea58b","to":"127c79a7f2112a42","stream-type":"stream Message"} {"level":"info","ts":"2026-04-22T09:35:34.102075Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"127c79a7f2112a42"} {"level":"warn","ts":"2026-04-22T09:35:34.146394Z","caller":"rafthttp/stream.go:420","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"127c79a7f2112a42","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:35:34.146791Z","caller":"rafthttp/stream.go:420","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"127c79a7f2112a42","error":"EOF"} {"level":"info","ts":"2026-04-22T09:35:34.161920Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"b96a40f6a27ea58b","to":"127c79a7f2112a42","stream-type":"stream MsgApp v2"} {"level":"warn","ts":"2026-04-22T09:35:34.161967Z","caller":"rafthttp/stream.go:264","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"127c79a7f2112a42"} {"level":"info","ts":"2026-04-22T09:35:34.161980Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"127c79a7f2112a42"} {"level":"info","ts":"2026-04-22T09:35:34.163002Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"b96a40f6a27ea58b","to":"127c79a7f2112a42","stream-type":"stream Message"} {"level":"warn","ts":"2026-04-22T09:35:34.163045Z","caller":"rafthttp/stream.go:264","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"127c79a7f2112a42"} {"level":"info","ts":"2026-04-22T09:35:34.163059Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"127c79a7f2112a42"} {"level":"info","ts":"2026-04-22T09:35:34.181365Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"127c79a7f2112a42"} {"level":"info","ts":"2026-04-22T09:35:34.186100Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"b96a40f6a27ea58b","remote-peer-id":"127c79a7f2112a42"} {"level":"info","ts":"2026-04-22T09:35:34.527817Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"b96a40f6a27ea58b switched to configuration voters=(1332073352022534722 13360562672580339083 16964418897735406127)"} {"level":"info","ts":"2026-04-22T09:35:34.528076Z","caller":"membership/cluster.go:550","msg":"promote member","cluster-id":"f43476f3367c14fb","local-member-id":"b96a40f6a27ea58b","promoted-member-id":"127c79a7f2112a42"} {"level":"info","ts":"2026-04-22T09:35:41.120958Z","caller":"traceutil/trace.go:172","msg":"trace[1001242569] linearizableReadLoop","detail":"{readStateIndex:825; appliedIndex:825; }","duration":"101.549807ms","start":"2026-04-22T09:35:41.019372Z","end":"2026-04-22T09:35:41.120922Z","steps":["trace[1001242569] 'read index received' (duration: 101.538807ms)","trace[1001242569] 'applied index is now lower than readState.Index' (duration: 8.94µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T09:35:41.121151Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"101.74423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" limit:1 ","response":"range_response_count:1 size:510"} {"level":"info","ts":"2026-04-22T09:35:41.121204Z","caller":"traceutil/trace.go:172","msg":"trace[175263564] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:758; }","duration":"101.816311ms","start":"2026-04-22T09:35:41.019367Z","end":"2026-04-22T09:35:41.121183Z","steps":["trace[175263564] 'agreement among raft nodes before linearized reading' (duration: 101.677789ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T09:35:44.240857Z","caller":"traceutil/trace.go:172","msg":"trace[1303359954] linearizableReadLoop","detail":"{readStateIndex:895; appliedIndex:896; }","duration":"206.563382ms","start":"2026-04-22T09:35:44.034277Z","end":"2026-04-22T09:35:44.240840Z","steps":["trace[1303359954] 'read index received' (duration: 206.559152ms)","trace[1303359954] 'applied index is now lower than readState.Index' (duration: 3.58µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T09:35:44.241065Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"206.761665ms","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-22T09:35:44.241130Z","caller":"traceutil/trace.go:172","msg":"trace[1083213611] range","detail":"{range_begin:/registry/resourceclaims; range_end:; response_count:0; response_revision:827; }","duration":"206.845576ms","start":"2026-04-22T09:35:44.034272Z","end":"2026-04-22T09:35:44.241118Z","steps":["trace[1083213611] 'agreement among raft nodes before linearized reading' (duration: 206.707364ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:35:44.265392Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"207.935983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" limit:1 ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-04-22T09:35:44.265470Z","caller":"traceutil/trace.go:172","msg":"trace[238365098] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:828; }","duration":"208.022654ms","start":"2026-04-22T09:35:44.057427Z","end":"2026-04-22T09:35:44.265449Z","steps":["trace[238365098] 'agreement among raft nodes before linearized reading' (duration: 207.834222ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T09:36:00.588996Z","caller":"traceutil/trace.go:172","msg":"trace[283603399] linearizableReadLoop","detail":"{readStateIndex:970; appliedIndex:970; }","duration":"125.875929ms","start":"2026-04-22T09:36:00.463091Z","end":"2026-04-22T09:36:00.588967Z","steps":["trace[283603399] 'read index received' (duration: 125.866488ms)","trace[283603399] 'applied index is now lower than readState.Index' (duration: 8.081µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T09:36:00.589114Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"126.00875ms","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-22T09:36:00.589175Z","caller":"traceutil/trace.go:172","msg":"trace[565175562] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:892; }","duration":"126.079341ms","start":"2026-04-22T09:36:00.463083Z","end":"2026-04-22T09:36:00.589162Z","steps":["trace[565175562] 'agreement among raft nodes before linearized reading' (duration: 125.98828ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T09:36:00.702804Z","caller":"traceutil/trace.go:172","msg":"trace[1498364194] linearizableReadLoop","detail":"{readStateIndex:971; appliedIndex:971; }","duration":"110.448038ms","start":"2026-04-22T09:36:00.592326Z","end":"2026-04-22T09:36:00.702774Z","steps":["trace[1498364194] 'read index received' (duration: 110.438178ms)","trace[1498364194] 'applied index is now lower than readState.Index' (duration: 8.13µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T09:36:00.703261Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"110.728722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T09:36:00.703399Z","caller":"traceutil/trace.go:172","msg":"trace[1636736591] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:893; }","duration":"111.066986ms","start":"2026-04-22T09:36:00.592311Z","end":"2026-04-22T09:36:00.703378Z","steps":["trace[1636736591] 'agreement among raft nodes before linearized reading' (duration: 110.565599ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T09:36:20.681297Z","caller":"traceutil/trace.go:172","msg":"trace[1068773058] linearizableReadLoop","detail":"{readStateIndex:1138; appliedIndex:1138; }","duration":"137.434285ms","start":"2026-04-22T09:36:20.543819Z","end":"2026-04-22T09:36:20.681253Z","steps":["trace[1068773058] 'read index received' (duration: 137.422025ms)","trace[1068773058] 'applied index is now lower than readState.Index' (duration: 11.19µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T09:36:20.693220Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"158.75859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T09:36:20.693287Z","caller":"traceutil/trace.go:172","msg":"trace[1107218285] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1043; }","duration":"158.843491ms","start":"2026-04-22T09:36:20.534431Z","end":"2026-04-22T09:36:20.693275Z","steps":["trace[1107218285] 'agreement among raft nodes before linearized reading' (duration: 147.009457ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T09:36:20.693727Z","caller":"traceutil/trace.go:172","msg":"trace[473419264] transaction","detail":"{read_only:false; response_revision:1044; number_of_response:1; }","duration":"158.758039ms","start":"2026-04-22T09:36:20.534961Z","end":"2026-04-22T09:36:20.693719Z","steps":["trace[473419264] 'process raft request' (duration: 158.600027ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T09:36:20.709373Z","caller":"traceutil/trace.go:172","msg":"trace[1566428261] transaction","detail":"{read_only:false; response_revision:1056; number_of_response:1; }","duration":"123.781955ms","start":"2026-04-22T09:36:20.585580Z","end":"2026-04-22T09:36:20.709361Z","steps":["trace[1566428261] 'process raft request' (duration: 123.700454ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:36:20.712819Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"132.03885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T09:36:20.712979Z","caller":"traceutil/trace.go:172","msg":"trace[2145599266] range","detail":"{range_begin:/registry/storageclasses; range_end:; response_count:0; response_revision:1057; }","duration":"132.346624ms","start":"2026-04-22T09:36:20.580623Z","end":"2026-04-22T09:36:20.712969Z","steps":["trace[2145599266] 'agreement among raft nodes before linearized reading' (duration: 131.779976ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T09:36:20.964303Z","caller":"traceutil/trace.go:172","msg":"trace[451032328] transaction","detail":"{read_only:false; response_revision:1071; number_of_response:1; }","duration":"115.338668ms","start":"2026-04-22T09:36:20.848941Z","end":"2026-04-22T09:36:20.964280Z","steps":["trace[451032328] 'process raft request' (duration: 115.118905ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T09:36:20.964364Z","caller":"traceutil/trace.go:172","msg":"trace[256491874] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1074; }","duration":"106.489845ms","start":"2026-04-22T09:36:20.857866Z","end":"2026-04-22T09:36:20.964356Z","steps":["trace[256491874] 'process raft request' (duration: 106.457805ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:36:21.965409Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11928801436764990824,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-22T09:36:22.174534Z","caller":"traceutil/trace.go:172","msg":"trace[1471702392] linearizableReadLoop","detail":"{readStateIndex:1215; appliedIndex:1215; }","duration":"710.083545ms","start":"2026-04-22T09:36:21.464416Z","end":"2026-04-22T09:36:22.174499Z","steps":["trace[1471702392] 'read index received' (duration: 710.078185ms)","trace[1471702392] 'applied index is now lower than readState.Index' (duration: 4.36µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T09:36:22.174694Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"710.289128ms","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-22T09:36:22.174724Z","caller":"traceutil/trace.go:172","msg":"trace[1594369421] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1090; }","duration":"710.337989ms","start":"2026-04-22T09:36:21.464377Z","end":"2026-04-22T09:36:22.174715Z","steps":["trace[1594369421] 'agreement among raft nodes before linearized reading' (duration: 710.260708ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T09:36:22.176697Z","caller":"traceutil/trace.go:172","msg":"trace[944532529] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"880.489592ms","start":"2026-04-22T09:36:21.296175Z","end":"2026-04-22T09:36:22.176664Z","steps":["trace[944532529] 'process raft request' (duration: 879.188634ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:36:22.177102Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:36:21.296138Z","time spent":"880.643963ms","remote":"127.0.0.1:54392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151221,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T09:36:22.177058Z","caller":"traceutil/trace.go:172","msg":"trace[2100407076] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1091; }","duration":"870.476133ms","start":"2026-04-22T09:36:21.306530Z","end":"2026-04-22T09:36:22.177006Z","steps":["trace[2100407076] 'process raft request' (duration: 870.148539ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:36:22.177294Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:36:21.306508Z","time spent":"870.664946ms","remote":"127.0.0.1:54392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":98741,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T09:36:22.186925Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"651.810389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T09:36:22.186980Z","caller":"traceutil/trace.go:172","msg":"trace[928096608] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1093; }","duration":"651.87234ms","start":"2026-04-22T09:36:21.535096Z","end":"2026-04-22T09:36:22.186968Z","steps":["trace[928096608] 'agreement among raft nodes before linearized reading' (duration: 651.790169ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:36:22.187005Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:36:21.535075Z","time spent":"651.92598ms","remote":"127.0.0.1:40686","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-22T09:36:22.186993Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"376.167667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T09:36:22.187047Z","caller":"traceutil/trace.go:172","msg":"trace[709089588] range","detail":"{range_begin:/registry/namespaces; range_end:; response_count:0; response_revision:1093; }","duration":"376.226188ms","start":"2026-04-22T09:36:21.810806Z","end":"2026-04-22T09:36:22.187032Z","steps":["trace[709089588] 'agreement among raft nodes before linearized reading' (duration: 376.122736ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:36:22.187097Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:36:21.810780Z","time spent":"376.309478ms","remote":"127.0.0.1:54516","response type":"/etcdserverpb.KV/Range","request count":0,"request size":24,"response count":0,"response size":29,"request content":"key:\"/registry/namespaces\" limit:1 "} {"level":"warn","ts":"2026-04-22T09:36:22.187149Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"240.967267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-22T09:36:22.187207Z","caller":"traceutil/trace.go:172","msg":"trace[2143086467] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1093; }","duration":"241.038498ms","start":"2026-04-22T09:36:21.946153Z","end":"2026-04-22T09:36:22.187192Z","steps":["trace[2143086467] 'agreement among raft nodes before linearized reading' (duration: 240.739434ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:36:22.187421Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"557.569506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-04-22T09:36:22.187495Z","caller":"traceutil/trace.go:172","msg":"trace[959069899] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1093; }","duration":"557.656397ms","start":"2026-04-22T09:36:21.629826Z","end":"2026-04-22T09:36:22.187483Z","steps":["trace[959069899] 'agreement among raft nodes before linearized reading' (duration: 557.414314ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:36:22.187532Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:36:21.629806Z","time spent":"557.719277ms","remote":"127.0.0.1:54834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":506,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 "} {"level":"warn","ts":"2026-04-22T09:36:27.227287Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"256.870691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" limit:1 ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-04-22T09:36:27.227365Z","caller":"traceutil/trace.go:172","msg":"trace[756718681] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1145; }","duration":"256.962803ms","start":"2026-04-22T09:36:26.970389Z","end":"2026-04-22T09:36:27.227351Z","steps":["trace[756718681] 'range keys from in-memory index tree' (duration: 254.810122ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:36:27.228170Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"199.685566ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-22T09:36:27.228549Z","caller":"traceutil/trace.go:172","msg":"trace[417182781] linearizableReadLoop","detail":"{readStateIndex:1306; appliedIndex:1302; }","duration":"188.483924ms","start":"2026-04-22T09:36:27.040045Z","end":"2026-04-22T09:36:27.228529Z","steps":["trace[417182781] 'read index received' (duration: 29.082299ms)","trace[417182781] 'applied index is now lower than readState.Index' (duration: 159.400545ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T09:36:27.228735Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"188.679696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-tlhnd\" limit:1 ","response":"range_response_count:1 size:18354"} {"level":"info","ts":"2026-04-22T09:36:27.228774Z","caller":"traceutil/trace.go:172","msg":"trace[185479496] range","detail":"{range_begin:/registry/pods/kube-system/cilium-tlhnd; range_end:; response_count:1; response_revision:1149; }","duration":"188.724377ms","start":"2026-04-22T09:36:27.040040Z","end":"2026-04-22T09:36:27.228764Z","steps":["trace[185479496] 'agreement among raft nodes before linearized reading' (duration: 188.556865ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T09:36:27.377409Z","caller":"traceutil/trace.go:172","msg":"trace[1558301093] transaction","detail":"{read_only:false; response_revision:1150; number_of_response:1; }","duration":"136.965227ms","start":"2026-04-22T09:36:27.240419Z","end":"2026-04-22T09:36:27.377384Z","steps":["trace[1558301093] 'process raft request' (duration: 136.512431ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T09:36:27.674263Z","caller":"traceutil/trace.go:172","msg":"trace[1701816183] linearizableReadLoop","detail":"{readStateIndex:1311; appliedIndex:1311; }","duration":"165.928934ms","start":"2026-04-22T09:36:27.508311Z","end":"2026-04-22T09:36:27.674240Z","steps":["trace[1701816183] 'read index received' (duration: 165.922624ms)","trace[1701816183] 'applied index is now lower than readState.Index' (duration: 5.04µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T09:36:27.674415Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"166.050836ms","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-22T09:36:27.674538Z","caller":"traceutil/trace.go:172","msg":"trace[36844538] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1153; }","duration":"166.216958ms","start":"2026-04-22T09:36:27.508304Z","end":"2026-04-22T09:36:27.674521Z","steps":["trace[36844538] 'agreement among raft nodes before linearized reading' (duration: 166.022675ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:36:27.675960Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"135.591598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T09:36:27.676018Z","caller":"traceutil/trace.go:172","msg":"trace[348837693] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1153; }","duration":"135.665439ms","start":"2026-04-22T09:36:27.540339Z","end":"2026-04-22T09:36:27.676004Z","steps":["trace[348837693] 'agreement among raft nodes before linearized reading' (duration: 135.548078ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:36:28.329763Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"288.160183ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"info","ts":"2026-04-22T09:36:29.200216Z","caller":"traceutil/trace.go:172","msg":"trace[470588646] linearizableReadLoop","detail":"{readStateIndex:1329; appliedIndex:1330; }","duration":"151.639723ms","start":"2026-04-22T09:36:29.048553Z","end":"2026-04-22T09:36:29.200193Z","steps":["trace[470588646] 'read index received' (duration: 151.630923ms)","trace[470588646] 'applied index is now lower than readState.Index' (duration: 7.59µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T09:36:29.201640Z","caller":"traceutil/trace.go:172","msg":"trace[128083759] transaction","detail":"{read_only:false; response_revision:1172; number_of_response:1; }","duration":"152.283481ms","start":"2026-04-22T09:36:29.049339Z","end":"2026-04-22T09:36:29.201623Z","steps":["trace[128083759] 'process raft request' (duration: 152.069208ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:36:29.201652Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"153.078962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-tlhnd\" limit:1 ","response":"range_response_count:1 size:18526"} {"level":"info","ts":"2026-04-22T09:36:29.201797Z","caller":"traceutil/trace.go:172","msg":"trace[325903185] range","detail":"{range_begin:/registry/pods/kube-system/cilium-tlhnd; range_end:; response_count:1; response_revision:1171; }","duration":"153.233704ms","start":"2026-04-22T09:36:29.048548Z","end":"2026-04-22T09:36:29.201782Z","steps":["trace[325903185] 'agreement among raft nodes before linearized reading' (duration: 151.709334ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T09:36:29.447873Z","caller":"traceutil/trace.go:172","msg":"trace[1442608923] transaction","detail":"{read_only:false; response_revision:1173; number_of_response:1; }","duration":"242.471135ms","start":"2026-04-22T09:36:29.205383Z","end":"2026-04-22T09:36:29.447855Z","steps":["trace[1442608923] 'process raft request' (duration: 242.329933ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T09:36:29.481260Z","caller":"traceutil/trace.go:172","msg":"trace[1469027318] transaction","detail":"{read_only:false; response_revision:1174; number_of_response:1; }","duration":"264.630678ms","start":"2026-04-22T09:36:29.216572Z","end":"2026-04-22T09:36:29.481202Z","steps":["trace[1469027318] 'process raft request' (duration: 264.393995ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T09:36:29.482005Z","caller":"traceutil/trace.go:172","msg":"trace[724460382] linearizableReadLoop","detail":"{readStateIndex:1331; appliedIndex:1335; }","duration":"153.420278ms","start":"2026-04-22T09:36:29.328567Z","end":"2026-04-22T09:36:29.481987Z","steps":["trace[724460382] 'read index received' (duration: 153.415397ms)","trace[724460382] 'applied index is now lower than readState.Index' (duration: 3.86µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T09:36:29.482145Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"153.562829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T09:36:29.482172Z","caller":"traceutil/trace.go:172","msg":"trace[1070067055] range","detail":"{range_begin:/registry/clusterroles; range_end:; response_count:0; response_revision:1176; }","duration":"153.60253ms","start":"2026-04-22T09:36:29.328562Z","end":"2026-04-22T09:36:29.482164Z","steps":["trace[1070067055] 'agreement among raft nodes before linearized reading' (duration: 153.540089ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T09:36:29.559994Z","caller":"traceutil/trace.go:172","msg":"trace[1387613490] transaction","detail":"{read_only:false; response_revision:1177; number_of_response:1; }","duration":"108.438062ms","start":"2026-04-22T09:36:29.451530Z","end":"2026-04-22T09:36:29.559968Z","steps":["trace[1387613490] 'process raft request' (duration: 108.248939ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:36:30.556340Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11928801436764990897,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T09:36:31.057185Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11928801436764990897,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-22T09:36:31.532540Z","caller":"traceutil/trace.go:172","msg":"trace[605607755] linearizableReadLoop","detail":"{readStateIndex:1337; appliedIndex:1337; }","duration":"1.476456818s","start":"2026-04-22T09:36:30.056056Z","end":"2026-04-22T09:36:31.532513Z","steps":["trace[605607755] 'read index received' (duration: 1.476448798s)","trace[605607755] 'applied index is now lower than readState.Index' (duration: 6.76µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T09:36:31.533054Z","caller":"traceutil/trace.go:172","msg":"trace[1010256013] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"1.475396234s","start":"2026-04-22T09:36:30.057604Z","end":"2026-04-22T09:36:31.533000Z","steps":["trace[1010256013] 'process raft request' (duration: 1.47510466s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:36:31.533043Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.476954405s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-tlhnd\" limit:1 ","response":"range_response_count:1 size:18624"} {"level":"info","ts":"2026-04-22T09:36:31.533134Z","caller":"traceutil/trace.go:172","msg":"trace[1596788437] range","detail":"{range_begin:/registry/pods/kube-system/cilium-tlhnd; range_end:; response_count:1; response_revision:1178; }","duration":"1.477069836s","start":"2026-04-22T09:36:30.056047Z","end":"2026-04-22T09:36:31.533117Z","steps":["trace[1596788437] 'agreement among raft nodes before linearized reading' (duration: 1.47661306s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:36:31.533175Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:36:30.056013Z","time spent":"1.477150898s","remote":"127.0.0.1:54672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":18648,"request content":"key:\"/registry/pods/kube-system/cilium-tlhnd\" limit:1 "} {"level":"warn","ts":"2026-04-22T09:36:31.533431Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:36:30.057585Z","time spent":"1.475536575s","remote":"127.0.0.1:54432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":763,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-22T09:36:31.565114Z","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":11928801436764990899,"received-request-id":11928801436764990897} {"level":"warn","ts":"2026-04-22T09:36:31.571652Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.491736435s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" limit:1 ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-04-22T09:36:31.571721Z","caller":"traceutil/trace.go:172","msg":"trace[947863436] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1182; }","duration":"1.491800176s","start":"2026-04-22T09:36:30.079904Z","end":"2026-04-22T09:36:31.571704Z","steps":["trace[947863436] 'agreement among raft nodes before linearized reading' (duration: 1.491664474s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:36:31.571755Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:36:30.079871Z","time spent":"1.491872458s","remote":"127.0.0.1:54834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" limit:1 "} {"level":"warn","ts":"2026-04-22T09:36:31.571770Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"181.876697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-22T09:36:31.571804Z","caller":"traceutil/trace.go:172","msg":"trace[1360072955] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1183; }","duration":"181.906997ms","start":"2026-04-22T09:36:31.389885Z","end":"2026-04-22T09:36:31.571792Z","steps":["trace[1360072955] 'agreement among raft nodes before linearized reading' (duration: 181.812386ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:36:31.571775Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.107765727s","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-22T09:36:31.571878Z","caller":"traceutil/trace.go:172","msg":"trace[124738634] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1183; }","duration":"1.107891368s","start":"2026-04-22T09:36:30.463962Z","end":"2026-04-22T09:36:31.571854Z","steps":["trace[124738634] 'agreement among raft nodes before linearized reading' (duration: 1.107695636s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:36:31.571650Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"959.24814ms","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-22T09:36:31.572033Z","caller":"traceutil/trace.go:172","msg":"trace[803353700] range","detail":"{range_begin:/registry/podtemplates; range_end:; response_count:0; response_revision:1182; }","duration":"959.654416ms","start":"2026-04-22T09:36:30.612372Z","end":"2026-04-22T09:36:31.572026Z","steps":["trace[803353700] 'agreement among raft nodes before linearized reading' (duration: 959.21407ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:36:31.572061Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:36:30.612343Z","time spent":"959.708566ms","remote":"127.0.0.1:54550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":26,"response count":0,"response size":29,"request content":"key:\"/registry/podtemplates\" limit:1 "} {"level":"warn","ts":"2026-04-22T09:36:31.571954Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"904.819396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 ","response":"range_response_count:1 size:481"} {"level":"warn","ts":"2026-04-22T09:36:31.572184Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.0369147s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T09:36:31.572408Z","caller":"traceutil/trace.go:172","msg":"trace[1037872687] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1183; }","duration":"1.037119462s","start":"2026-04-22T09:36:30.535250Z","end":"2026-04-22T09:36:31.572370Z","steps":["trace[1037872687] 'agreement among raft nodes before linearized reading' (duration: 1.036861219s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:36:31.572465Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:36:30.535221Z","time spent":"1.037233853s","remote":"127.0.0.1:40686","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-22T09:36:31.572224Z","caller":"traceutil/trace.go:172","msg":"trace[1229799310] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1183; }","duration":"905.09363ms","start":"2026-04-22T09:36:30.667116Z","end":"2026-04-22T09:36:31.572210Z","steps":["trace[1229799310] 'agreement among raft nodes before linearized reading' (duration: 904.791436ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:36:31.572610Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:36:30.667096Z","time spent":"905.470656ms","remote":"127.0.0.1:54834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 "} {"level":"warn","ts":"2026-04-22T09:36:52.160661Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:47312","server-name":"","error":"EOF"} {"level":"info","ts":"2026-04-22T09:36:54.525523Z","caller":"traceutil/trace.go:172","msg":"trace[1652769864] linearizableReadLoop","detail":"{readStateIndex:1688; appliedIndex:1688; }","duration":"128.526656ms","start":"2026-04-22T09:36:54.396972Z","end":"2026-04-22T09:36:54.525499Z","steps":["trace[1652769864] 'read index received' (duration: 128.517556ms)","trace[1652769864] 'applied index is now lower than readState.Index' (duration: 7.18µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T09:36:54.525813Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"128.825249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-22T09:36:54.525928Z","caller":"traceutil/trace.go:172","msg":"trace[91472462] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1468; }","duration":"128.956791ms","start":"2026-04-22T09:36:54.396948Z","end":"2026-04-22T09:36:54.525905Z","steps":["trace[91472462] 'agreement among raft nodes before linearized reading' (duration: 128.640827ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T09:36:54.721293Z","caller":"traceutil/trace.go:172","msg":"trace[976028836] transaction","detail":"{read_only:false; number_of_response:0; response_revision:1470; }","duration":"117.246396ms","start":"2026-04-22T09:36:54.604024Z","end":"2026-04-22T09:36:54.721270Z","steps":["trace[976028836] 'process raft request' (duration: 117.168885ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T09:36:54.748141Z","caller":"traceutil/trace.go:172","msg":"trace[1105750996] linearizableReadLoop","detail":"{readStateIndex:1691; appliedIndex:1691; }","duration":"127.438521ms","start":"2026-04-22T09:36:54.620681Z","end":"2026-04-22T09:36:54.748120Z","steps":["trace[1105750996] 'read index received' (duration: 127.432721ms)","trace[1105750996] 'applied index is now lower than readState.Index' (duration: 4.79µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T09:36:54.748571Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"127.849736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/controller-1\" limit:1 ","response":"range_response_count:1 size:1730"} {"level":"info","ts":"2026-04-22T09:36:54.748664Z","caller":"traceutil/trace.go:172","msg":"trace[1482035952] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/controller-1; range_end:; response_count:1; response_revision:1471; }","duration":"127.972228ms","start":"2026-04-22T09:36:54.620675Z","end":"2026-04-22T09:36:54.748647Z","steps":["trace[1482035952] 'agreement among raft nodes before linearized reading' (duration: 127.639413ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:36:54.759981Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39040","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:36:54.772332Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39060","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:36:54.796681Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39082","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:36:54.830094Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39084","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:36:55.308217Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:39104","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-04-22T09:38:46.963932Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11928801436764991746,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T09:38:47.465073Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11928801436764991746,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-22T09:38:47.769532Z","caller":"traceutil/trace.go:172","msg":"trace[411330966] linearizableReadLoop","detail":"{readStateIndex:2289; appliedIndex:2284; }","duration":"1.305906459s","start":"2026-04-22T09:38:46.463612Z","end":"2026-04-22T09:38:47.769519Z","steps":["trace[411330966] 'read index received' (duration: 1.301350211s)","trace[411330966] 'applied index is now lower than readState.Index' (duration: 4.555448ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T09:38:47.769653Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.306029272s","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-22T09:38:47.769675Z","caller":"traceutil/trace.go:172","msg":"trace[1906651127] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1997; }","duration":"1.306064003s","start":"2026-04-22T09:38:46.463604Z","end":"2026-04-22T09:38:47.769668Z","steps":["trace[1906651127] 'agreement among raft nodes before linearized reading' (duration: 1.306013722s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:38:47.771274Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.236497784s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T09:38:47.771316Z","caller":"traceutil/trace.go:172","msg":"trace[1621388888] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1997; }","duration":"1.236550076s","start":"2026-04-22T09:38:46.534756Z","end":"2026-04-22T09:38:47.771306Z","steps":["trace[1621388888] 'agreement among raft nodes before linearized reading' (duration: 1.236471123s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:38:47.771313Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"837.363336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" limit:1 ","response":"range_response_count:1 size:510"} {"level":"info","ts":"2026-04-22T09:38:47.771341Z","caller":"traceutil/trace.go:172","msg":"trace[300272993] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1997; }","duration":"837.394087ms","start":"2026-04-22T09:38:46.933940Z","end":"2026-04-22T09:38:47.771334Z","steps":["trace[300272993] 'agreement among raft nodes before linearized reading' (duration: 837.284144ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:38:47.771339Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:38:46.534735Z","time spent":"1.236598847s","remote":"127.0.0.1:40686","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-22T09:38:47.771359Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:38:46.933923Z","time spent":"837.430639ms","remote":"127.0.0.1:54834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":534,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" limit:1 "} {"level":"warn","ts":"2026-04-22T09:38:47.771421Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"317.476014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T09:38:47.771519Z","caller":"traceutil/trace.go:172","msg":"trace[1982147105] range","detail":"{range_begin:/registry/configmaps; range_end:; response_count:0; response_revision:1997; }","duration":"317.578507ms","start":"2026-04-22T09:38:47.453917Z","end":"2026-04-22T09:38:47.771496Z","steps":["trace[1982147105] 'agreement among raft nodes before linearized reading' (duration: 317.436793ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:38:47.771559Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:38:47.453904Z","time spent":"317.645299ms","remote":"127.0.0.1:54496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":24,"response count":0,"response size":29,"request content":"key:\"/registry/configmaps\" limit:1 "} {"level":"info","ts":"2026-04-22T09:38:52.322582Z","caller":"traceutil/trace.go:172","msg":"trace[1959281931] linearizableReadLoop","detail":"{readStateIndex:2304; appliedIndex:2295; }","duration":"431.862161ms","start":"2026-04-22T09:38:51.890704Z","end":"2026-04-22T09:38:52.322567Z","steps":["trace[1959281931] 'read index received' (duration: 397.385405ms)","trace[1959281931] 'applied index is now lower than readState.Index' (duration: 34.475456ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T09:38:52.322937Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"432.212951ms","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-22T09:38:52.323003Z","caller":"traceutil/trace.go:172","msg":"trace[562218292] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2011; }","duration":"432.261402ms","start":"2026-04-22T09:38:51.890702Z","end":"2026-04-22T09:38:52.322963Z","steps":["trace[562218292] 'agreement among raft nodes before linearized reading' (duration: 432.073737ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:38:52.324386Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"431.884842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T09:38:52.324419Z","caller":"traceutil/trace.go:172","msg":"trace[1292677483] range","detail":"{range_begin:/registry/runtimeclasses; range_end:; response_count:0; response_revision:2011; }","duration":"431.918932ms","start":"2026-04-22T09:38:51.892493Z","end":"2026-04-22T09:38:52.324412Z","steps":["trace[1292677483] 'agreement among raft nodes before linearized reading' (duration: 431.864441ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:38:52.324441Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:38:51.892477Z","time spent":"431.957484ms","remote":"127.0.0.1:54962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":0,"response size":29,"request content":"key:\"/registry/runtimeclasses\" limit:1 "} {"level":"warn","ts":"2026-04-22T09:38:52.324665Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"432.083577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 ","response":"range_response_count:1 size:483"} {"level":"info","ts":"2026-04-22T09:38:52.324709Z","caller":"traceutil/trace.go:172","msg":"trace[1466310594] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2011; }","duration":"432.126218ms","start":"2026-04-22T09:38:51.892572Z","end":"2026-04-22T09:38:52.324698Z","steps":["trace[1466310594] 'agreement among raft nodes before linearized reading' (duration: 432.030606ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:38:52.324718Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"223.907932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.143\" limit:1 ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-22T09:38:52.324742Z","caller":"traceutil/trace.go:172","msg":"trace[1138049252] range","detail":"{range_begin:/registry/masterleases/199.19.213.143; range_end:; response_count:1; response_revision:2011; }","duration":"223.933142ms","start":"2026-04-22T09:38:52.100802Z","end":"2026-04-22T09:38:52.324736Z","steps":["trace[1138049252] 'agreement among raft nodes before linearized reading' (duration: 223.866601ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:38:52.324741Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:38:51.892569Z","time spent":"432.161479ms","remote":"127.0.0.1:54834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":507,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 "} {"level":"warn","ts":"2026-04-22T09:38:52.324740Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"432.235991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattributesclasses\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T09:38:52.324776Z","caller":"traceutil/trace.go:172","msg":"trace[785072724] range","detail":"{range_begin:/registry/volumeattributesclasses; range_end:; response_count:0; response_revision:2011; }","duration":"432.270632ms","start":"2026-04-22T09:38:51.892494Z","end":"2026-04-22T09:38:52.324764Z","steps":["trace[785072724] 'agreement among raft nodes before linearized reading' (duration: 432.213781ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:38:52.324801Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:38:51.892482Z","time spent":"432.311864ms","remote":"127.0.0.1:55118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":29,"request content":"key:\"/registry/volumeattributesclasses\" limit:1 "} {"level":"warn","ts":"2026-04-22T09:38:52.324826Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"424.422074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T09:38:52.324867Z","caller":"traceutil/trace.go:172","msg":"trace[1053564706] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2011; }","duration":"424.457565ms","start":"2026-04-22T09:38:51.900398Z","end":"2026-04-22T09:38:52.324856Z","steps":["trace[1053564706] 'agreement among raft nodes before linearized reading' (duration: 424.404963ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:38:52.324890Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:38:51.900384Z","time spent":"424.500596ms","remote":"127.0.0.1:40686","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-22T09:38:52.324884Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"410.550038ms","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-22T09:38:52.325206Z","caller":"traceutil/trace.go:172","msg":"trace[1068204731] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2011; }","duration":"411.032761ms","start":"2026-04-22T09:38:51.914165Z","end":"2026-04-22T09:38:52.325197Z","steps":["trace[1068204731] 'agreement among raft nodes before linearized reading' (duration: 410.498306ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:38:52.325229Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:38:51.914154Z","time spent":"411.067142ms","remote":"127.0.0.1:54834","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-22T09:38:52.325792Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"433.227749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" limit:1 ","response":"range_response_count:1 size:510"} {"level":"info","ts":"2026-04-22T09:38:52.325946Z","caller":"traceutil/trace.go:172","msg":"trace[1451946003] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2011; }","duration":"433.396284ms","start":"2026-04-22T09:38:51.892536Z","end":"2026-04-22T09:38:52.325932Z","steps":["trace[1451946003] 'agreement among raft nodes before linearized reading' (duration: 433.161627ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:38:52.325980Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:38:51.892533Z","time spent":"433.439795ms","remote":"127.0.0.1:54834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":534,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" limit:1 "} {"level":"info","ts":"2026-04-22T09:39:12.257249Z","caller":"traceutil/trace.go:172","msg":"trace[899048712] linearizableReadLoop","detail":"{readStateIndex:2393; appliedIndex:2393; }","duration":"155.823318ms","start":"2026-04-22T09:39:12.101402Z","end":"2026-04-22T09:39:12.257225Z","steps":["trace[899048712] 'read index received' (duration: 155.816488ms)","trace[899048712] 'applied index is now lower than readState.Index' (duration: 5.47µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T09:39:12.257568Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"156.167477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.143\" limit:1 ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-22T09:39:12.257629Z","caller":"traceutil/trace.go:172","msg":"trace[1473485354] range","detail":"{range_begin:/registry/masterleases/199.19.213.143; range_end:; response_count:1; response_revision:2088; }","duration":"156.244349ms","start":"2026-04-22T09:39:12.101370Z","end":"2026-04-22T09:39:12.257615Z","steps":["trace[1473485354] 'agreement among raft nodes before linearized reading' (duration: 156.010393ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T09:39:13.614520Z","caller":"traceutil/trace.go:172","msg":"trace[1512148342] linearizableReadLoop","detail":"{readStateIndex:2402; appliedIndex:2402; }","duration":"150.5946ms","start":"2026-04-22T09:39:13.463890Z","end":"2026-04-22T09:39:13.614484Z","steps":["trace[1512148342] 'read index received' (duration: 150.58566ms)","trace[1512148342] 'applied index is now lower than readState.Index' (duration: 7.63µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T09:39:13.614708Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"150.770434ms","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-22T09:39:13.614806Z","caller":"traceutil/trace.go:172","msg":"trace[939696857] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2095; }","duration":"150.909498ms","start":"2026-04-22T09:39:13.463881Z","end":"2026-04-22T09:39:13.614790Z","steps":["trace[939696857] 'agreement among raft nodes before linearized reading' (duration: 150.721233ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:39:14.114701Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11928801436764991872,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T09:39:14.615810Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11928801436764991872,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-22T09:39:15.014610Z","logger":"raft","caller":"v3@v3.6.0/raft.go:988","msg":"b96a40f6a27ea58b is starting a new election at term 2"} {"level":"info","ts":"2026-04-22T09:39:15.014651Z","logger":"raft","caller":"v3@v3.6.0/raft.go:930","msg":"b96a40f6a27ea58b became pre-candidate at term 2"} {"level":"info","ts":"2026-04-22T09:39:15.014669Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1064","msg":"b96a40f6a27ea58b [logterm: 2, index: 2402] sent MsgPreVote request to 127c79a7f2112a42 at term 2"} {"level":"info","ts":"2026-04-22T09:39:15.014677Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1064","msg":"b96a40f6a27ea58b [logterm: 2, index: 2402] sent MsgPreVote request to eb6db91b2c71522f at term 2"} {"level":"info","ts":"2026-04-22T09:39:15.014686Z","logger":"raft","caller":"v3@v3.6.0/node.go:376","msg":"raft.node: b96a40f6a27ea58b lost leader eb6db91b2c71522f at term 2"} {"level":"info","ts":"2026-04-22T09:39:15.014714Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1077","msg":"b96a40f6a27ea58b received MsgPreVoteResp from b96a40f6a27ea58b at term 2"} {"level":"info","ts":"2026-04-22T09:39:15.014724Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1693","msg":"b96a40f6a27ea58b has received 1 MsgPreVoteResp votes and 0 vote rejections"} {"level":"warn","ts":"2026-04-22T09:39:15.116615Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11928801436764991872,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-22T09:39:15.245933Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"b96a40f6a27ea58b became follower at term 2"} {"level":"info","ts":"2026-04-22T09:39:15.246032Z","logger":"raft","caller":"v3@v3.6.0/node.go:370","msg":"raft.node: b96a40f6a27ea58b elected leader eb6db91b2c71522f at term 2"} {"level":"warn","ts":"2026-04-22T09:39:15.247966Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.712851393s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"etcdserver: leader changed"} {"level":"info","ts":"2026-04-22T09:39:15.248048Z","caller":"traceutil/trace.go:172","msg":"trace[1702248271] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.712945585s","start":"2026-04-22T09:39:13.535089Z","end":"2026-04-22T09:39:15.248035Z","steps":["trace[1702248271] 'agreement among raft nodes before linearized reading' (duration: 1.712849313s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:39:15.248107Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:39:13.535067Z","time spent":"1.713031728s","remote":"127.0.0.1:40686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-22T09:39:15.251869Z","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":11928801436764991873,"received-request-id":11928801436764991872} {"level":"warn","ts":"2026-04-22T09:39:15.535273Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"258.671286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-22T09:39:15.535349Z","caller":"traceutil/trace.go:172","msg":"trace[295584131] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"258.756578ms","start":"2026-04-22T09:39:15.276576Z","end":"2026-04-22T09:39:15.535333Z","steps":["trace[295584131] 'agreement among raft nodes before linearized reading' (duration: 258.668156ms)"],"step_count":1} 2026/04/22 09:39:15 WARNING: [core] [Server #5]grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-22T09:39:15.750955Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11928801436764991873,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T09:39:16.251479Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11928801436764991873,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T09:39:16.414933Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.163099696s","expected-duration":"1s"} {"level":"info","ts":"2026-04-22T09:39:16.421027Z","caller":"traceutil/trace.go:172","msg":"trace[446923787] linearizableReadLoop","detail":"{readStateIndex:2412; appliedIndex:2412; }","duration":"1.170091495s","start":"2026-04-22T09:39:15.250917Z","end":"2026-04-22T09:39:16.421009Z","steps":["trace[446923787] 'read index received' (duration: 1.170085845s)","trace[446923787] 'applied index is now lower than readState.Index' (duration: 4.65µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T09:39:16.421286Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.170346083s","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-22T09:39:16.421358Z","caller":"traceutil/trace.go:172","msg":"trace[1802806724] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2104; }","duration":"1.170434075s","start":"2026-04-22T09:39:15.250912Z","end":"2026-04-22T09:39:16.421346Z","steps":["trace[1802806724] 'agreement among raft nodes before linearized reading' (duration: 1.170167928s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:39:16.921421Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11928801436764991875,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T09:39:17.264485Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.0000071s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-22T09:39:17.264660Z","caller":"traceutil/trace.go:172","msg":"trace[401531264] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000242896s","start":"2026-04-22T09:39:15.264348Z","end":"2026-04-22T09:39:17.264591Z","steps":["trace[401531264] 'agreement among raft nodes before linearized reading' (duration: 2.00000288s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:39:17.265751Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:39:15.264330Z","time spent":"2.001408016s","remote":"127.0.0.1:40686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/22 09:39:17 WARNING: [core] [Server #5]grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-22T09:39:17.422544Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11928801436764991875,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T09:39:17.441262Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.02033732s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-22T09:39:17.441635Z","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":11928801436764991875,"received-request-id":11928801436764991873} {"level":"info","ts":"2026-04-22T09:39:17.451009Z","caller":"traceutil/trace.go:172","msg":"trace[312326692] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"1.369233556s","start":"2026-04-22T09:39:16.081762Z","end":"2026-04-22T09:39:17.450995Z","steps":["trace[312326692] 'process raft request' (duration: 1.359973649s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:39:17.451530Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:39:16.081740Z","time spent":"1.369636497s","remote":"127.0.0.1:54834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":536,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T09:39:17.487541Z","caller":"traceutil/trace.go:172","msg":"trace[2064945466] linearizableReadLoop","detail":"{readStateIndex:2420; appliedIndex:2420; }","duration":"1.066398172s","start":"2026-04-22T09:39:16.421116Z","end":"2026-04-22T09:39:17.487514Z","steps":["trace[2064945466] 'read index received' (duration: 1.066387462s)","trace[2064945466] 'applied index is now lower than readState.Index' (duration: 9.15µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T09:39:17.487749Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.067420279s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T09:39:17.487891Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.086841116s","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-22T09:39:17.488089Z","caller":"traceutil/trace.go:172","msg":"trace[1674379021] range","detail":"{range_begin:/registry/jobs; range_end:; response_count:0; response_revision:2111; }","duration":"2.087034631s","start":"2026-04-22T09:39:15.401041Z","end":"2026-04-22T09:39:17.488076Z","steps":["trace[1674379021] 'agreement among raft nodes before linearized reading' (duration: 2.086820245s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:39:17.487915Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.952491838s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T09:39:17.488282Z","caller":"traceutil/trace.go:172","msg":"trace[228458428] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2111; }","duration":"1.952862338s","start":"2026-04-22T09:39:15.535409Z","end":"2026-04-22T09:39:17.488271Z","steps":["trace[228458428] 'agreement among raft nodes before linearized reading' (duration: 1.952468978s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:39:17.488315Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:39:15.535398Z","time spent":"1.952909919s","remote":"127.0.0.1:40712","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-22T09:39:17.488329Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:39:15.401022Z","time spent":"2.087154293s","remote":"127.0.0.1:54784","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":"warn","ts":"2026-04-22T09:39:17.487961Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.604735783s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T09:39:17.488453Z","caller":"traceutil/trace.go:172","msg":"trace[1271304599] transaction","detail":"{read_only:false; response_revision:2112; number_of_response:1; }","duration":"1.027953513s","start":"2026-04-22T09:39:16.460491Z","end":"2026-04-22T09:39:17.488444Z","steps":["trace[1271304599] 'process raft request' (duration: 1.027549753s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:39:17.488515Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:39:16.460472Z","time spent":"1.028001794s","remote":"127.0.0.1:54834","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-22T09:39:17.488457Z","caller":"traceutil/trace.go:172","msg":"trace[1903156867] range","detail":"{range_begin:/registry/horizontalpodautoscalers; range_end:; response_count:0; response_revision:2111; }","duration":"1.605228795s","start":"2026-04-22T09:39:15.883221Z","end":"2026-04-22T09:39:17.488449Z","steps":["trace[1903156867] 'agreement among raft nodes before linearized reading' (duration: 1.604726522s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:39:17.488622Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:39:15.883205Z","time spent":"1.60540549s","remote":"127.0.0.1:54738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":29,"request content":"key:\"/registry/horizontalpodautoscalers\" limit:1 "} {"level":"warn","ts":"2026-04-22T09:39:17.488013Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.237033902s","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-22T09:39:17.488688Z","caller":"traceutil/trace.go:172","msg":"trace[862243910] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2111; }","duration":"2.237696269s","start":"2026-04-22T09:39:15.250974Z","end":"2026-04-22T09:39:17.488670Z","steps":["trace[862243910] 'agreement among raft nodes before linearized reading' (duration: 2.237001871s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:39:17.488719Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:39:15.250955Z","time spent":"2.23775438s","remote":"127.0.0.1:54834","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-22T09:39:17.488035Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.237029912s","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-22T09:39:17.488806Z","caller":"traceutil/trace.go:172","msg":"trace[1514625690] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions; range_end:; response_count:0; response_revision:2111; }","duration":"2.237796541s","start":"2026-04-22T09:39:15.251001Z","end":"2026-04-22T09:39:17.488798Z","steps":["trace[1514625690] 'agreement among raft nodes before linearized reading' (duration: 2.237020001s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:39:17.488850Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:39:15.250997Z","time spent":"2.237825402s","remote":"127.0.0.1:54392","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-22T09:39:17.488058Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.086893707s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T09:39:17.489014Z","caller":"traceutil/trace.go:172","msg":"trace[1233141030] range","detail":"{range_begin:/registry/daemonsets; range_end:; response_count:0; response_revision:2111; }","duration":"2.087845952s","start":"2026-04-22T09:39:15.401161Z","end":"2026-04-22T09:39:17.489007Z","steps":["trace[1233141030] 'agreement among raft nodes before linearized reading' (duration: 2.086886107s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:39:17.489037Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:39:15.401154Z","time spent":"2.087876622s","remote":"127.0.0.1:55230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":24,"response count":0,"response size":29,"request content":"key:\"/registry/daemonsets\" limit:1 "} {"level":"warn","ts":"2026-04-22T09:39:17.489152Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.06668817s","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-22T09:39:17.487996Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.004003149s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 ","response":"range_response_count:1 size:483"} {"level":"warn","ts":"2026-04-22T09:39:17.489359Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"527.320061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T09:39:17.489405Z","caller":"traceutil/trace.go:172","msg":"trace[1412744992] range","detail":"{range_begin:/registry/clusterrolebindings; range_end:; response_count:0; response_revision:2112; }","duration":"527.365693ms","start":"2026-04-22T09:39:16.962032Z","end":"2026-04-22T09:39:17.489398Z","steps":["trace[1412744992] 'agreement among raft nodes before linearized reading' (duration: 527.307051ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:39:17.489420Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:39:16.962011Z","time spent":"527.403733ms","remote":"127.0.0.1:55056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":33,"response count":0,"response size":29,"request content":"key:\"/registry/clusterrolebindings\" limit:1 "} {"level":"warn","ts":"2026-04-22T09:39:17.489573Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.030384055s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T09:39:17.489592Z","caller":"traceutil/trace.go:172","msg":"trace[1364646231] range","detail":"{range_begin:/registry/csistoragecapacities; range_end:; response_count:0; response_revision:2112; }","duration":"1.030403565s","start":"2026-04-22T09:39:16.459184Z","end":"2026-04-22T09:39:17.489588Z","steps":["trace[1364646231] 'agreement among raft nodes before linearized reading' (duration: 1.030375175s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:39:17.489605Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:39:16.459164Z","time spent":"1.030437957s","remote":"127.0.0.1:55146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":29,"request content":"key:\"/registry/csistoragecapacities\" limit:1 "} {"level":"info","ts":"2026-04-22T09:39:17.489608Z","caller":"traceutil/trace.go:172","msg":"trace[1997024431] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2112; }","duration":"1.067140602s","start":"2026-04-22T09:39:16.422452Z","end":"2026-04-22T09:39:17.489592Z","steps":["trace[1997024431] 'agreement among raft nodes before linearized reading' (duration: 1.06667127s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:39:17.489654Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"172.928266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" limit:1 ","response":"range_response_count:1 size:511"} {"level":"info","ts":"2026-04-22T09:39:17.489666Z","caller":"traceutil/trace.go:172","msg":"trace[820837603] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2112; }","duration":"172.939606ms","start":"2026-04-22T09:39:17.316722Z","end":"2026-04-22T09:39:17.489662Z","steps":["trace[820837603] 'agreement among raft nodes before linearized reading' (duration: 172.790543ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:39:17.489692Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"952.403729ms","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-22T09:39:17.490498Z","caller":"traceutil/trace.go:172","msg":"trace[445388587] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2112; }","duration":"953.2098ms","start":"2026-04-22T09:39:16.537281Z","end":"2026-04-22T09:39:17.490491Z","steps":["trace[445388587] 'agreement among raft nodes before linearized reading' (duration: 952.293406ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:39:17.490526Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:39:16.537268Z","time spent":"953.24916ms","remote":"127.0.0.1:54834","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":"info","ts":"2026-04-22T09:39:17.489731Z","caller":"traceutil/trace.go:172","msg":"trace[8441178] range","detail":"{range_begin:/registry/csidrivers; range_end:; response_count:0; response_revision:2111; }","duration":"1.06747872s","start":"2026-04-22T09:39:16.420302Z","end":"2026-04-22T09:39:17.487781Z","steps":["trace[8441178] 'agreement among raft nodes before linearized reading' (duration: 1.067365327s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:39:17.491868Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:39:16.420286Z","time spent":"1.071560784s","remote":"127.0.0.1:55140","response type":"/etcdserverpb.KV/Range","request count":0,"request size":24,"response count":0,"response size":29,"request content":"key:\"/registry/csidrivers\" limit:1 "} {"level":"info","ts":"2026-04-22T09:39:17.492397Z","caller":"traceutil/trace.go:172","msg":"trace[1871354874] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2111; }","duration":"2.005202559s","start":"2026-04-22T09:39:15.483985Z","end":"2026-04-22T09:39:17.489187Z","steps":["trace[1871354874] 'agreement among raft nodes before linearized reading' (duration: 2.003921086s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:39:17.492472Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:39:15.483963Z","time spent":"2.008473473s","remote":"127.0.0.1:54834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":507,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 "} {"level":"info","ts":"2026-04-22T09:39:19.218108Z","caller":"traceutil/trace.go:172","msg":"trace[986320795] linearizableReadLoop","detail":"{readStateIndex:2431; appliedIndex:2431; }","duration":"308.411912ms","start":"2026-04-22T09:39:18.909673Z","end":"2026-04-22T09:39:19.218085Z","steps":["trace[986320795] 'read index received' (duration: 308.402022ms)","trace[986320795] 'applied index is now lower than readState.Index' (duration: 5.79µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T09:39:19.218218Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"308.530455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T09:39:19.218248Z","caller":"traceutil/trace.go:172","msg":"trace[1232408795] range","detail":"{range_begin:/registry/rolebindings; range_end:; response_count:0; response_revision:2121; }","duration":"308.571996ms","start":"2026-04-22T09:39:18.909667Z","end":"2026-04-22T09:39:19.218239Z","steps":["trace[1232408795] 'agreement among raft nodes before linearized reading' (duration: 308.506914ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T09:39:19.218277Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-04-22T09:39:18.909641Z","time spent":"308.627998ms","remote":"127.0.0.1:55030","response type":"/etcdserverpb.KV/Range","request count":0,"request size":26,"response count":0,"response size":29,"request content":"key:\"/registry/rolebindings\" limit:1 "}