{"level":"warn","ts":"2026-07-31T00:56:37.028646Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"warn","ts":"2026-07-31T00:56:37.029305Z","caller":"etcdmain/config.go:270","msg":"--snapshot-count is deprecated in 3.6 and will be decommissioned in 3.7."} {"level":"info","ts":"2026-07-31T00:56:37.029322Z","caller":"etcdmain/etcd.go:64","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.38: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.204.45.38:2380","--initial-cluster=controller-1=https://199.204.45.240:2380,controller-3=https://199.204.45.38:2380,controller-2=https://199.204.45.74:2380","--initial-cluster-state=existing","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.38:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.38:2380","--name=controller-3","--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-07-31T00:56:37.029413Z","caller":"etcdmain/etcd.go:124","msg":"Initialize and start etcd server","data-dir":"/var/lib/etcd","dir-type":"empty"} {"level":"warn","ts":"2026-07-31T00:56:37.029427Z","caller":"embed/config.go:1209","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-31T00:56:37.029442Z","caller":"embed/etcd.go:138","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-07-31T00:56:37.029464Z","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-07-31T00:56:37.030682Z","caller":"embed/etcd.go:146","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"]} {"level":"info","ts":"2026-07-31T00:56:37.030884Z","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-3","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"experimental-local-address":"","cors":["*"],"host-whitelist":["*"],"initial-cluster":"controller-1=https://199.204.45.240:2380,controller-2=https://199.204.45.74:2380,controller-3=https://199.204.45.38: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-07-31T00:56:37.032295Z","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: 0xc00038e0e8}"} {"level":"info","ts":"2026-07-31T00:56:37.036059Z","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-07-31T00:56:37.036101Z","caller":"storage/backend.go:80","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.080327ms"} {"level":"info","ts":"2026-07-31T00:56:37.036123Z","caller":"etcdserver/bootstrap.go:220","msg":"restore consistentIndex","index":0} {"level":"info","ts":"2026-07-31T00:56:37.036799Z","caller":"etcdserver/bootstrap.go:94","msg":"bootstrapping cluster"} {"level":"info","ts":"2026-07-31T00:56:37.049555Z","caller":"netutil/netutil.go:113","msg":"resolved URL Host","url":"https://199.204.45.240:2380","host":"199.204.45.240:2380","resolved-addr":"199.204.45.240:2380"} {"level":"info","ts":"2026-07-31T00:56:37.049616Z","caller":"netutil/netutil.go:113","msg":"resolved URL Host","url":"https://199.204.45.38:2380","host":"199.204.45.38:2380","resolved-addr":"199.204.45.38:2380"} {"level":"info","ts":"2026-07-31T00:56:37.049691Z","caller":"netutil/netutil.go:113","msg":"resolved URL Host","url":"https://199.204.45.74:2380","host":"199.204.45.74:2380","resolved-addr":"199.204.45.74:2380"} {"level":"info","ts":"2026-07-31T00:56:37.049705Z","caller":"netutil/netutil.go:113","msg":"resolved URL Host","url":"https://199.204.45.38:2380","host":"199.204.45.38:2380","resolved-addr":"199.204.45.38:2380"} {"level":"info","ts":"2026-07-31T00:56:37.049720Z","caller":"netutil/netutil.go:113","msg":"resolved URL Host","url":"https://199.204.45.74:2380","host":"199.204.45.74:2380","resolved-addr":"199.204.45.74:2380"} {"level":"info","ts":"2026-07-31T00:56:37.049731Z","caller":"netutil/netutil.go:113","msg":"resolved URL Host","url":"https://199.204.45.240:2380","host":"199.204.45.240:2380","resolved-addr":"199.204.45.240:2380"} {"level":"info","ts":"2026-07-31T00:56:37.067831Z","caller":"etcdserver/bootstrap.go:101","msg":"bootstrapping storage"} {"level":"info","ts":"2026-07-31T00:56:37.076196Z","caller":"etcdserver/bootstrap.go:109","msg":"bootstrapping raft"} {"level":"info","ts":"2026-07-31T00:56:37.076246Z","caller":"etcdserver/bootstrap.go:499","msg":"starting local member","local-member-id":"6ee6c9b8c553b21e","cluster-id":"cae704afa9813e87"} {"level":"info","ts":"2026-07-31T00:56:37.076272Z","caller":"etcdserver/server.go:312","msg":"bootstrap successfully"} {"level":"info","ts":"2026-07-31T00:56:37.076366Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"6ee6c9b8c553b21e switched to configuration voters=()"} {"level":"info","ts":"2026-07-31T00:56:37.076411Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"6ee6c9b8c553b21e became follower at term 0"} {"level":"info","ts":"2026-07-31T00:56:37.076421Z","logger":"raft","caller":"v3@v3.6.0/raft.go:493","msg":"newRaft 6ee6c9b8c553b21e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"warn","ts":"2026-07-31T00:56:37.082774Z","caller":"auth/store.go:1135","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-31T00:56:37.084119Z","caller":"mvcc/kvstore.go:408","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-31T00:56:37.086448Z","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-07-31T00:56:37.087709Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"4e46287fb5aa4785"} {"level":"info","ts":"2026-07-31T00:56:37.087754Z","caller":"rafthttp/transport.go:286","msg":"added new remote peer","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"4e46287fb5aa4785","remote-peer-urls":["https://199.204.45.240:2380"]} {"level":"info","ts":"2026-07-31T00:56:37.087786Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"b05345c86fc8b1e7"} {"level":"info","ts":"2026-07-31T00:56:37.087798Z","caller":"rafthttp/transport.go:286","msg":"added new remote peer","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"b05345c86fc8b1e7","remote-peer-urls":["https://199.204.45.74:2380"]} {"level":"info","ts":"2026-07-31T00:56:37.087824Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"4e46287fb5aa4785"} {"level":"info","ts":"2026-07-31T00:56:37.087840Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"4e46287fb5aa4785"} {"level":"info","ts":"2026-07-31T00:56:37.090568Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"4e46287fb5aa4785"} {"level":"info","ts":"2026-07-31T00:56:37.091071Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"4e46287fb5aa4785"} {"level":"info","ts":"2026-07-31T00:56:37.092535Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"4e46287fb5aa4785"} {"level":"info","ts":"2026-07-31T00:56:37.092899Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"4e46287fb5aa4785","remote-peer-urls":["https://199.204.45.240:2380"]} {"level":"info","ts":"2026-07-31T00:56:37.093098Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"b05345c86fc8b1e7"} {"level":"info","ts":"2026-07-31T00:56:37.092693Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"4e46287fb5aa4785"} {"level":"info","ts":"2026-07-31T00:56:37.092811Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"4e46287fb5aa4785"} {"level":"info","ts":"2026-07-31T00:56:37.093782Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"b05345c86fc8b1e7"} {"level":"info","ts":"2026-07-31T00:56:37.093987Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"b05345c86fc8b1e7"} {"level":"info","ts":"2026-07-31T00:56:37.094112Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"b05345c86fc8b1e7","remote-peer-urls":["https://199.204.45.74:2380"]} {"level":"info","ts":"2026-07-31T00:56:37.094205Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"b05345c86fc8b1e7"} {"level":"info","ts":"2026-07-31T00:56:37.094019Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"b05345c86fc8b1e7"} {"level":"info","ts":"2026-07-31T00:56:37.094436Z","caller":"etcdserver/server.go:598","msg":"starting etcd server","local-member-id":"6ee6c9b8c553b21e","local-server-version":"3.6.4","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-31T00:56:37.094142Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"b05345c86fc8b1e7"} {"level":"info","ts":"2026-07-31T00:56:37.094894Z","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-07-31T00:56:37.095404Z","caller":"embed/etcd.go:292","msg":"now serving peer/client/metrics","local-member-id":"6ee6c9b8c553b21e","initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-31T00:56:37.098407Z","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-07-31T00:56:37.098475Z","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-07-31T00:56:37.098488Z","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-07-31T00:56:37.098680Z","caller":"etcdserver/server.go:499","msg":"starting initial election tick advance","election-ticks":10} {"level":"info","ts":"2026-07-31T00:56:37.098852Z","caller":"embed/etcd.go:890","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-31T00:56:37.098914Z","caller":"embed/etcd.go:640","msg":"serving peer traffic","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-07-31T00:56:37.098931Z","caller":"embed/etcd.go:611","msg":"cmux::serve","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-07-31T00:56:37.098929Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"b05345c86fc8b1e7"} {"level":"info","ts":"2026-07-31T00:56:37.099201Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1116","msg":"6ee6c9b8c553b21e [term: 0] received a MsgHeartbeat message with higher term from 4e46287fb5aa4785 [term: 2]"} {"level":"info","ts":"2026-07-31T00:56:37.099222Z","logger":"raft","caller":"v3@v3.6.0/raft.go:897","msg":"6ee6c9b8c553b21e became follower at term 2"} {"level":"info","ts":"2026-07-31T00:56:37.099233Z","logger":"raft","caller":"v3@v3.6.0/node.go:370","msg":"raft.node: 6ee6c9b8c553b21e elected leader 4e46287fb5aa4785 at term 2"} {"level":"info","ts":"2026-07-31T00:56:37.099314Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"6ee6c9b8c553b21e","to":"4e46287fb5aa4785","stream-type":"stream MsgApp v2"} {"level":"info","ts":"2026-07-31T00:56:37.099343Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"4e46287fb5aa4785"} {"level":"info","ts":"2026-07-31T00:56:37.099364Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"6ee6c9b8c553b21e","to":"b05345c86fc8b1e7","stream-type":"stream Message"} {"level":"info","ts":"2026-07-31T00:56:37.099392Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"4e46287fb5aa4785"} {"level":"info","ts":"2026-07-31T00:56:37.099387Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"b05345c86fc8b1e7"} {"level":"info","ts":"2026-07-31T00:56:37.099426Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"b05345c86fc8b1e7"} {"level":"info","ts":"2026-07-31T00:56:37.099588Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"6ee6c9b8c553b21e","to":"4e46287fb5aa4785","stream-type":"stream Message"} {"level":"info","ts":"2026-07-31T00:56:37.099607Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"4e46287fb5aa4785"} {"level":"info","ts":"2026-07-31T00:56:37.099907Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"6ee6c9b8c553b21e","to":"b05345c86fc8b1e7","stream-type":"stream MsgApp v2"} {"level":"info","ts":"2026-07-31T00:56:37.099937Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"b05345c86fc8b1e7"} {"level":"info","ts":"2026-07-31T00:56:37.109059Z","caller":"rafthttp/http.go:258","msg":"receiving database snapshot","local-member-id":"6ee6c9b8c553b21e","remote-snapshot-sender-id":"4e46287fb5aa4785","incoming-snapshot-index":689,"incoming-snapshot-message-size-bytes":8743,"incoming-snapshot-message-size":"8.7 kB"} {"level":"info","ts":"2026-07-31T00:56:37.109823Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"4e46287fb5aa4785"} {"level":"info","ts":"2026-07-31T00:56:37.114293Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"4e46287fb5aa4785"} {"level":"info","ts":"2026-07-31T00:56:37.118221Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"b05345c86fc8b1e7"} {"level":"info","ts":"2026-07-31T00:56:37.118389Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"b05345c86fc8b1e7"} {"level":"info","ts":"2026-07-31T00:56:37.122668Z","caller":"snap/db.go:65","msg":"saved database snapshot to disk","path":"/var/lib/etcd/member/snap/00000000000002b1.snap.db","bytes":1003520,"size":"1.0 MB"} {"level":"info","ts":"2026-07-31T00:56:37.122721Z","caller":"rafthttp/http.go:287","msg":"received and saved database snapshot","local-member-id":"6ee6c9b8c553b21e","remote-snapshot-sender-id":"4e46287fb5aa4785","incoming-snapshot-index":689,"incoming-snapshot-size-bytes":1003520,"incoming-snapshot-size":"1.0 MB","download-took":"13.795849ms"} {"level":"info","ts":"2026-07-31T00:56:37.122830Z","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: 689, term: 2]"} {"level":"info","ts":"2026-07-31T00:56:37.122964Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"6ee6c9b8c553b21e switched to configuration voters=(5640240112301918085 12705575700913500647) learners=(7991296384237285918)"} {"level":"info","ts":"2026-07-31T00:56:37.122997Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1935","msg":"6ee6c9b8c553b21e [commit: 689, lastindex: 689, lastterm: 2] restored snapshot [index: 689, term: 2]"} {"level":"info","ts":"2026-07-31T00:56:37.123035Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1844","msg":"6ee6c9b8c553b21e [commit: 689] restored snapshot [index: 689, term: 2]"} {"level":"info","ts":"2026-07-31T00:56:37.123198Z","caller":"etcdserver/server.go:1007","msg":"applying snapshot","current-snapshot-index":0,"current-applied-index":0,"incoming-leader-snapshot-index":689,"incoming-leader-snapshot-term":2} {"level":"info","ts":"2026-07-31T00:56:37.125965Z","caller":"etcdserver/raft.go:276","msg":"applied incoming Raft snapshot","snapshot-index":689} {"level":"info","ts":"2026-07-31T00:56:37.126475Z","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: 0xc000136138}"} {"level":"info","ts":"2026-07-31T00:56:37.127246Z","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-07-31T00:56:37.127387Z","caller":"storage/backend.go:80","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"1.048015ms"} {"level":"info","ts":"2026-07-31T00:56:37.127463Z","caller":"etcdserver/server.go:1055","msg":"restoring lease store"} {"level":"info","ts":"2026-07-31T00:56:37.128563Z","caller":"etcdserver/server.go:1059","msg":"restored lease store"} {"level":"info","ts":"2026-07-31T00:56:37.128608Z","caller":"etcdserver/server.go:1062","msg":"restoring mvcc store"} {"level":"info","ts":"2026-07-31T00:56:37.131033Z","caller":"mvcc/kvstore.go:408","msg":"kvstore restored","current-rev":632} {"level":"info","ts":"2026-07-31T00:56:37.131070Z","caller":"etcdserver/server.go:1070","msg":"restored mvcc store","consistent-index":689} {"level":"info","ts":"2026-07-31T00:56:37.131091Z","caller":"etcdserver/server.go:1090","msg":"restoring alarm store"} {"level":"info","ts":"2026-07-31T00:56:37.131205Z","caller":"etcdserver/server.go:1078","msg":"closing old backend file"} {"level":"info","ts":"2026-07-31T00:56:37.133666Z","caller":"etcdserver/server.go:1096","msg":"restored alarm store"} {"level":"info","ts":"2026-07-31T00:56:37.133701Z","caller":"etcdserver/server.go:1099","msg":"restoring auth store"} {"level":"info","ts":"2026-07-31T00:56:37.133753Z","caller":"etcdserver/server.go:1103","msg":"restored auth store"} {"level":"info","ts":"2026-07-31T00:56:37.133770Z","caller":"etcdserver/server.go:1106","msg":"restoring v2 store"} {"level":"info","ts":"2026-07-31T00:56:37.133801Z","caller":"etcdserver/server.go:1080","msg":"closed old backend file"} {"level":"info","ts":"2026-07-31T00:56:37.134449Z","caller":"etcdserver/server.go:1115","msg":"restored v2 store"} {"level":"info","ts":"2026-07-31T00:56:37.134491Z","caller":"etcdserver/server.go:1119","msg":"restoring cluster configuration"} {"level":"info","ts":"2026-07-31T00:56:37.134562Z","caller":"api/capability.go:76","msg":"enabled capabilities for version","cluster-version":"3.6"} {"level":"info","ts":"2026-07-31T00:56:37.134590Z","caller":"membership/cluster.go:297","msg":"recovered/added member from store","cluster-id":"cae704afa9813e87","local-member-id":"6ee6c9b8c553b21e","recovered-remote-peer-id":"6ee6c9b8c553b21e","recovered-remote-peer-urls":["https://199.204.45.38:2380"],"recovered-remote-peer-is-learner":true} {"level":"info","ts":"2026-07-31T00:56:37.134615Z","caller":"membership/cluster.go:297","msg":"recovered/added member from store","cluster-id":"cae704afa9813e87","local-member-id":"6ee6c9b8c553b21e","recovered-remote-peer-id":"b05345c86fc8b1e7","recovered-remote-peer-urls":["https://199.204.45.74:2380"],"recovered-remote-peer-is-learner":false} {"level":"info","ts":"2026-07-31T00:56:37.134625Z","caller":"membership/cluster.go:297","msg":"recovered/added member from store","cluster-id":"cae704afa9813e87","local-member-id":"6ee6c9b8c553b21e","recovered-remote-peer-id":"4e46287fb5aa4785","recovered-remote-peer-urls":["https://199.204.45.240:2380"],"recovered-remote-peer-is-learner":false} {"level":"info","ts":"2026-07-31T00:56:37.134637Z","caller":"membership/cluster.go:307","msg":"set cluster version from store","cluster-version":"3.6"} {"level":"info","ts":"2026-07-31T00:56:37.134673Z","caller":"etcdserver/server.go:1123","msg":"restored cluster configuration"} {"level":"info","ts":"2026-07-31T00:56:37.134685Z","caller":"etcdserver/server.go:1124","msg":"removing old peers from network"} {"level":"info","ts":"2026-07-31T00:56:37.134698Z","caller":"rafthttp/peer.go:316","msg":"stopping remote peer","remote-peer-id":"4e46287fb5aa4785"} {"level":"warn","ts":"2026-07-31T00:56:37.134784Z","caller":"rafthttp/stream.go:285","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"4e46287fb5aa4785"} {"level":"info","ts":"2026-07-31T00:56:37.134811Z","caller":"rafthttp/stream.go:293","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"4e46287fb5aa4785"} {"level":"warn","ts":"2026-07-31T00:56:37.134846Z","caller":"rafthttp/stream.go:285","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"4e46287fb5aa4785"} {"level":"info","ts":"2026-07-31T00:56:37.134875Z","caller":"rafthttp/stream.go:293","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"4e46287fb5aa4785"} {"level":"info","ts":"2026-07-31T00:56:37.134912Z","caller":"rafthttp/pipeline.go:85","msg":"stopped HTTP pipelining with remote peer","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"4e46287fb5aa4785"} {"level":"warn","ts":"2026-07-31T00:56:37.135089Z","caller":"rafthttp/stream.go:420","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"4e46287fb5aa4785","error":"context canceled"} {"level":"warn","ts":"2026-07-31T00:56:37.135130Z","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"4e46287fb5aa4785","error":"failed to read 4e46287fb5aa4785 on stream MsgApp v2 (context canceled)"} {"level":"info","ts":"2026-07-31T00:56:37.135156Z","caller":"rafthttp/stream.go:441","msg":"stopped stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"4e46287fb5aa4785"} {"level":"warn","ts":"2026-07-31T00:56:37.135302Z","caller":"rafthttp/stream.go:420","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"4e46287fb5aa4785","error":"context canceled"} {"level":"info","ts":"2026-07-31T00:56:37.135338Z","caller":"rafthttp/stream.go:441","msg":"stopped stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"4e46287fb5aa4785"} {"level":"info","ts":"2026-07-31T00:56:37.135347Z","caller":"rafthttp/peer.go:321","msg":"stopped remote peer","remote-peer-id":"4e46287fb5aa4785"} {"level":"info","ts":"2026-07-31T00:56:37.135362Z","caller":"rafthttp/transport.go:354","msg":"removed remote peer","local-member-id":"6ee6c9b8c553b21e","removed-remote-peer-id":"4e46287fb5aa4785"} {"level":"info","ts":"2026-07-31T00:56:37.135373Z","caller":"rafthttp/peer.go:316","msg":"stopping remote peer","remote-peer-id":"b05345c86fc8b1e7"} {"level":"warn","ts":"2026-07-31T00:56:37.135401Z","caller":"rafthttp/stream.go:285","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"b05345c86fc8b1e7"} {"level":"info","ts":"2026-07-31T00:56:37.135426Z","caller":"rafthttp/stream.go:293","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","remote-peer-id":"b05345c86fc8b1e7"} {"level":"warn","ts":"2026-07-31T00:56:37.135455Z","caller":"rafthttp/stream.go:285","msg":"closed TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"b05345c86fc8b1e7"} {"level":"info","ts":"2026-07-31T00:56:37.135472Z","caller":"rafthttp/stream.go:293","msg":"stopped TCP streaming connection with remote peer","stream-writer-type":"stream Message","remote-peer-id":"b05345c86fc8b1e7"} {"level":"info","ts":"2026-07-31T00:56:37.135535Z","caller":"rafthttp/pipeline.go:85","msg":"stopped HTTP pipelining with remote peer","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"b05345c86fc8b1e7"} {"level":"warn","ts":"2026-07-31T00:56:37.135646Z","caller":"rafthttp/stream.go:420","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"b05345c86fc8b1e7","error":"context canceled"} {"level":"warn","ts":"2026-07-31T00:56:37.135689Z","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"b05345c86fc8b1e7","error":"failed to read b05345c86fc8b1e7 on stream MsgApp v2 (context canceled)"} {"level":"info","ts":"2026-07-31T00:56:37.135712Z","caller":"rafthttp/stream.go:441","msg":"stopped stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"b05345c86fc8b1e7"} {"level":"warn","ts":"2026-07-31T00:56:37.135777Z","caller":"rafthttp/stream.go:420","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"b05345c86fc8b1e7","error":"context canceled"} {"level":"info","ts":"2026-07-31T00:56:37.135823Z","caller":"rafthttp/stream.go:441","msg":"stopped stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"b05345c86fc8b1e7"} {"level":"info","ts":"2026-07-31T00:56:37.135839Z","caller":"rafthttp/peer.go:321","msg":"stopped remote peer","remote-peer-id":"b05345c86fc8b1e7"} {"level":"info","ts":"2026-07-31T00:56:37.135856Z","caller":"rafthttp/transport.go:354","msg":"removed remote peer","local-member-id":"6ee6c9b8c553b21e","removed-remote-peer-id":"b05345c86fc8b1e7"} {"level":"info","ts":"2026-07-31T00:56:37.135868Z","caller":"etcdserver/server.go:1129","msg":"removed old peers from network"} {"level":"info","ts":"2026-07-31T00:56:37.135877Z","caller":"etcdserver/server.go:1130","msg":"adding peers from new cluster configuration"} {"level":"info","ts":"2026-07-31T00:56:37.135899Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"4e46287fb5aa4785"} {"level":"info","ts":"2026-07-31T00:56:37.135923Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"4e46287fb5aa4785"} {"level":"info","ts":"2026-07-31T00:56:37.136138Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"4e46287fb5aa4785"} {"level":"info","ts":"2026-07-31T00:56:37.136147Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"4e46287fb5aa4785"} {"level":"info","ts":"2026-07-31T00:56:37.136162Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"4e46287fb5aa4785","remote-peer-urls":["https://199.204.45.240:2380"]} {"level":"info","ts":"2026-07-31T00:56:37.136184Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"b05345c86fc8b1e7"} {"level":"info","ts":"2026-07-31T00:56:37.136156Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"4e46287fb5aa4785"} {"level":"info","ts":"2026-07-31T00:56:37.136203Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"b05345c86fc8b1e7"} {"level":"info","ts":"2026-07-31T00:56:37.136213Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"4e46287fb5aa4785"} {"level":"info","ts":"2026-07-31T00:56:37.136227Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"4e46287fb5aa4785"} {"level":"info","ts":"2026-07-31T00:56:37.139309Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"b05345c86fc8b1e7"} {"level":"info","ts":"2026-07-31T00:56:37.139628Z","caller":"rafthttp/stream.go:168","msg":"started stream writer with remote peer","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"b05345c86fc8b1e7"} {"level":"info","ts":"2026-07-31T00:56:37.146576Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"b05345c86fc8b1e7"} {"level":"info","ts":"2026-07-31T00:56:37.146661Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"b05345c86fc8b1e7","remote-peer-urls":["https://199.204.45.74:2380"]} {"level":"info","ts":"2026-07-31T00:56:37.146603Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"b05345c86fc8b1e7"} {"level":"info","ts":"2026-07-31T00:56:37.146686Z","caller":"rafthttp/stream.go:394","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"b05345c86fc8b1e7"} {"level":"info","ts":"2026-07-31T00:56:37.146873Z","caller":"etcdserver/server.go:1139","msg":"added peers from new cluster configuration"} {"level":"info","ts":"2026-07-31T00:56:37.147063Z","caller":"etcdserver/server.go:1015","msg":"applied snapshot","current-snapshot-index":689,"current-applied-index":689,"incoming-leader-snapshot-index":689,"incoming-leader-snapshot-term":2} {"level":"info","ts":"2026-07-31T00:56:37.152268Z","caller":"etcdserver/server.go:1804","msg":"published local member to cluster through raft","local-member-id":"6ee6c9b8c553b21e","local-member-attributes":"{Name:controller-3 ClientURLs:[https://199.204.45.38:2379]}","cluster-id":"cae704afa9813e87","publish-timeout":"7s"} {"level":"info","ts":"2026-07-31T00:56:37.152425Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"6ee6c9b8c553b21e","to":"4e46287fb5aa4785","stream-type":"stream MsgApp v2"} {"level":"info","ts":"2026-07-31T00:56:37.152461Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"4e46287fb5aa4785"} {"level":"info","ts":"2026-07-31T00:56:37.152545Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"4e46287fb5aa4785"} {"level":"info","ts":"2026-07-31T00:56:37.152711Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"6ee6c9b8c553b21e","to":"4e46287fb5aa4785","stream-type":"stream Message"} {"level":"info","ts":"2026-07-31T00:56:37.152929Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"4e46287fb5aa4785"} {"level":"info","ts":"2026-07-31T00:56:37.153019Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"6ee6c9b8c553b21e","to":"b05345c86fc8b1e7","stream-type":"stream Message"} {"level":"info","ts":"2026-07-31T00:56:37.153180Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"b05345c86fc8b1e7"} {"level":"info","ts":"2026-07-31T00:56:37.153254Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"b05345c86fc8b1e7"} {"level":"info","ts":"2026-07-31T00:56:37.153032Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-31T00:56:37.153430Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-31T00:56:37.153469Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-31T00:56:37.153095Z","caller":"embed/serve.go:138","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-31T00:56:37.155219Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"warn","ts":"2026-07-31T00:56:37.155460Z","caller":"v3rpc/grpc.go:52","msg":"etcdserver: failed to register grpc metrics","error":"duplicate metrics collector registration attempted"} {"level":"info","ts":"2026-07-31T00:56:37.155637Z","caller":"v3rpc/health.go:63","msg":"grpc service status changed","service":"","status":"SERVING"} {"level":"info","ts":"2026-07-31T00:56:37.156177Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"4e46287fb5aa4785"} {"level":"info","ts":"2026-07-31T00:56:37.157628Z","caller":"rafthttp/stream.go:248","msg":"set message encoder","from":"6ee6c9b8c553b21e","to":"b05345c86fc8b1e7","stream-type":"stream MsgApp v2"} {"level":"info","ts":"2026-07-31T00:56:37.157659Z","caller":"rafthttp/stream.go:273","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"b05345c86fc8b1e7"} {"level":"info","ts":"2026-07-31T00:56:37.158359Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-31T00:56:37.158570Z","caller":"embed/serve.go:283","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.38:2379"} {"level":"info","ts":"2026-07-31T00:56:37.161488Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"4e46287fb5aa4785"} {"level":"info","ts":"2026-07-31T00:56:37.166294Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"b05345c86fc8b1e7"} {"level":"info","ts":"2026-07-31T00:56:37.169070Z","caller":"rafthttp/stream.go:411","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"6ee6c9b8c553b21e","remote-peer-id":"b05345c86fc8b1e7"} {"level":"info","ts":"2026-07-31T00:56:37.204845Z","caller":"etcdserver/server.go:522","msg":"initialized peer connections; fast-forwarding election ticks","local-member-id":"6ee6c9b8c553b21e","forward-ticks":8,"forward-duration":"800ms","election-ticks":10,"election-timeout":"1s","active-remote-members":2} {"level":"warn","ts":"2026-07-31T00:56:37.394420Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"199.204.45.38:50900","server-name":"","error":"EOF"} {"level":"info","ts":"2026-07-31T00:56:37.396967Z","logger":"raft","caller":"v3@v3.6.0/raft.go:1981","msg":"6ee6c9b8c553b21e switched to configuration voters=(5640240112301918085 7991296384237285918 12705575700913500647)"} {"level":"info","ts":"2026-07-31T00:56:37.397156Z","caller":"membership/cluster.go:550","msg":"promote member","cluster-id":"cae704afa9813e87","local-member-id":"6ee6c9b8c553b21e","promoted-member-id":"6ee6c9b8c553b21e"} {"level":"warn","ts":"2026-07-31T00:56:37.495055Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43228","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.496208Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43242","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.522831Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43256","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.532478Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43274","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.545840Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43320","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.564063Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43348","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.572702Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43370","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.583485Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43392","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.594566Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43408","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.605842Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43418","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.615187Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43432","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.624739Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43444","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.635303Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43450","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.645085Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43478","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.664199Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43500","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.673779Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43520","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.685675Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43548","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.695914Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43562","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.706456Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43570","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.715406Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43598","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.727708Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43638","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.756038Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43658","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.768769Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43670","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.782806Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43682","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.793138Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43702","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.802628Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43714","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.814655Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43744","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.825885Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43768","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.832806Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43788","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.843296Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43810","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.854944Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43828","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.863053Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43846","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.883408Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43860","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.918396Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43888","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.930898Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43918","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.942268Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43920","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.953172Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43940","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.965049Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43946","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.973434Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43968","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.982985Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:43980","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.990981Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44016","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:37.999549Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44026","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:38.008670Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44046","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:38.018062Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44066","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:38.034022Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44104","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:38.042495Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44110","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:38.050828Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44134","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:38.059985Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44154","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:38.068035Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44170","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:38.078839Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44196","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:38.089368Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44206","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:38.095809Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44234","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:38.102567Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44268","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:38.111558Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44272","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:38.120482Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44296","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:38.130726Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44306","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:38.158722Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44312","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:38.180809Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44328","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:56:38.241800Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:44350","server-name":"","error":"EOF"} {"level":"info","ts":"2026-07-31T00:56:46.362365Z","caller":"traceutil/trace.go:172","msg":"trace[564223099] linearizableReadLoop","detail":"{readStateIndex:771; appliedIndex:771; }","duration":"258.00454ms","start":"2026-07-31T00:56:46.104337Z","end":"2026-07-31T00:56:46.362341Z","steps":["trace[564223099] 'read index received' (duration: 257.99484ms)","trace[564223099] 'applied index is now lower than readState.Index' (duration: 8.31µs)"],"step_count":2} {"level":"warn","ts":"2026-07-31T00:56:46.362577Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"258.168445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/controller-3\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T00:56:46.362619Z","caller":"traceutil/trace.go:172","msg":"trace[523849723] range","detail":"{range_begin:/registry/csinodes/controller-3; range_end:; response_count:0; response_revision:706; }","duration":"258.273997ms","start":"2026-07-31T00:56:46.104332Z","end":"2026-07-31T00:56:46.362606Z","steps":["trace[523849723] 'agreement among raft nodes before linearized reading' (duration: 258.128424ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T00:56:46.362891Z","caller":"traceutil/trace.go:172","msg":"trace[1620606134] transaction","detail":"{read_only:false; response_revision:707; number_of_response:1; }","duration":"259.10073ms","start":"2026-07-31T00:56:46.103771Z","end":"2026-07-31T00:56:46.362872Z","steps":["trace[1620606134] 'process raft request' (duration: 258.673108ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:56:46.366344Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"110.57176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-31T00:56:46.366434Z","caller":"traceutil/trace.go:172","msg":"trace[1481829348] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:714; }","duration":"110.688783ms","start":"2026-07-31T00:56:46.255729Z","end":"2026-07-31T00:56:46.366417Z","steps":["trace[1481829348] 'agreement among raft nodes before linearized reading' (duration: 110.445757ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T00:56:47.991033Z","caller":"traceutil/trace.go:172","msg":"trace[876630979] linearizableReadLoop","detail":"{readStateIndex:787; appliedIndex:787; }","duration":"479.016187ms","start":"2026-07-31T00:56:47.511992Z","end":"2026-07-31T00:56:47.991008Z","steps":["trace[876630979] 'read index received' (duration: 479.009997ms)","trace[876630979] 'applied index is now lower than readState.Index' (duration: 5.2µs)"],"step_count":2} {"level":"warn","ts":"2026-07-31T00:56:47.991262Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"479.251264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-qjhld\" limit:1 ","response":"range_response_count:1 size:5039"} {"level":"info","ts":"2026-07-31T00:56:47.991355Z","caller":"traceutil/trace.go:172","msg":"trace[1277920588] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-qjhld; range_end:; response_count:1; response_revision:722; }","duration":"479.368597ms","start":"2026-07-31T00:56:47.511969Z","end":"2026-07-31T00:56:47.991338Z","steps":["trace[1277920588] 'agreement among raft nodes before linearized reading' (duration: 479.12418ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:56:47.991399Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:56:47.511945Z","time spent":"479.444539ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":5062,"request content":"key:\"/registry/pods/kube-system/kube-proxy-qjhld\" limit:1 "} {"level":"info","ts":"2026-07-31T00:56:48.294169Z","caller":"traceutil/trace.go:172","msg":"trace[1379988190] linearizableReadLoop","detail":"{readStateIndex:790; appliedIndex:790; }","duration":"244.943389ms","start":"2026-07-31T00:56:48.049210Z","end":"2026-07-31T00:56:48.294153Z","steps":["trace[1379988190] 'read index received' (duration: 244.938469ms)","trace[1379988190] 'applied index is now lower than readState.Index' (duration: 4.19µs)"],"step_count":2} {"level":"warn","ts":"2026-07-31T00:56:48.294310Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"245.082283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T00:56:48.294385Z","caller":"traceutil/trace.go:172","msg":"trace[124114803] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:724; }","duration":"245.169045ms","start":"2026-07-31T00:56:48.049203Z","end":"2026-07-31T00:56:48.294372Z","steps":["trace[124114803] 'agreement among raft nodes before linearized reading' (duration: 245.028001ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T00:56:48.294735Z","caller":"traceutil/trace.go:172","msg":"trace[1820813169] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"293.042375ms","start":"2026-07-31T00:56:48.001681Z","end":"2026-07-31T00:56:48.294724Z","steps":["trace[1820813169] 'process raft request' (duration: 292.953912ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:56:48.295686Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"176.803995ms","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-07-31T00:56:48.295729Z","caller":"traceutil/trace.go:172","msg":"trace[1824021858] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:726; }","duration":"176.860146ms","start":"2026-07-31T00:56:48.118860Z","end":"2026-07-31T00:56:48.295721Z","steps":["trace[1824021858] 'agreement among raft nodes before linearized reading' (duration: 176.726893ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T00:56:52.486986Z","caller":"traceutil/trace.go:172","msg":"trace[320678759] linearizableReadLoop","detail":"{readStateIndex:810; appliedIndex:810; }","duration":"187.970073ms","start":"2026-07-31T00:56:52.298991Z","end":"2026-07-31T00:56:52.486961Z","steps":["trace[320678759] 'read index received' (duration: 187.963053ms)","trace[320678759] 'applied index is now lower than readState.Index' (duration: 5.79µs)"],"step_count":2} {"level":"warn","ts":"2026-07-31T00:56:52.487204Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"188.19322ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T00:56:52.487249Z","caller":"traceutil/trace.go:172","msg":"trace[2012791876] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:741; }","duration":"188.254202ms","start":"2026-07-31T00:56:52.298984Z","end":"2026-07-31T00:56:52.487238Z","steps":["trace[2012791876] 'agreement among raft nodes before linearized reading' (duration: 188.163419ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:56:52.489476Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"183.624847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T00:56:52.489563Z","caller":"traceutil/trace.go:172","msg":"trace[1463042966] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:742; }","duration":"183.717269ms","start":"2026-07-31T00:56:52.305827Z","end":"2026-07-31T00:56:52.489545Z","steps":["trace[1463042966] 'agreement among raft nodes before linearized reading' (duration: 183.572585ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:56:56.561745Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"263.658116ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T00:56:56.561809Z","caller":"traceutil/trace.go:172","msg":"trace[1548008053] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:761; }","duration":"263.744139ms","start":"2026-07-31T00:56:56.298055Z","end":"2026-07-31T00:56:56.561800Z","steps":["trace[1548008053] 'agreement among raft nodes before linearized reading' (duration: 263.624905ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T00:56:56.561646Z","caller":"traceutil/trace.go:172","msg":"trace[1990430944] linearizableReadLoop","detail":"{readStateIndex:832; appliedIndex:832; }","duration":"263.508922ms","start":"2026-07-31T00:56:56.298064Z","end":"2026-07-31T00:56:56.561573Z","steps":["trace[1990430944] 'read index received' (duration: 263.503552ms)","trace[1990430944] 'applied index is now lower than readState.Index' (duration: 4.28µs)"],"step_count":2} {"level":"warn","ts":"2026-07-31T00:56:56.610857Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"306.115101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T00:56:56.611057Z","caller":"traceutil/trace.go:172","msg":"trace[607602187] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:761; }","duration":"306.354569ms","start":"2026-07-31T00:56:56.304675Z","end":"2026-07-31T00:56:56.611030Z","steps":["trace[607602187] 'agreement among raft nodes before linearized reading' (duration: 306.052169ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:56:56.611142Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:56:56.304654Z","time spent":"306.477242ms","remote":"127.0.0.1:43236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-31T00:56:56.610901Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"285.800877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/controller-3\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T00:56:56.611349Z","caller":"traceutil/trace.go:172","msg":"trace[2143234965] range","detail":"{range_begin:/registry/leases/kube-node-lease/controller-3; range_end:; response_count:0; response_revision:761; }","duration":"286.24951ms","start":"2026-07-31T00:56:56.325061Z","end":"2026-07-31T00:56:56.611310Z","steps":["trace[2143234965] 'agreement among raft nodes before linearized reading' (duration: 285.723654ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T00:56:56.824341Z","caller":"traceutil/trace.go:172","msg":"trace[643106219] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"143.622875ms","start":"2026-07-31T00:56:56.680697Z","end":"2026-07-31T00:56:56.824320Z","steps":["trace[643106219] 'process raft request' (duration: 137.366895ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T00:57:01.614708Z","caller":"traceutil/trace.go:172","msg":"trace[1510343286] linearizableReadLoop","detail":"{readStateIndex:855; appliedIndex:855; }","duration":"316.198094ms","start":"2026-07-31T00:57:01.298493Z","end":"2026-07-31T00:57:01.614691Z","steps":["trace[1510343286] 'read index received' (duration: 316.192993ms)","trace[1510343286] 'applied index is now lower than readState.Index' (duration: 4.191µs)"],"step_count":2} {"level":"warn","ts":"2026-07-31T00:57:01.614845Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"316.336938ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T00:57:01.615030Z","caller":"traceutil/trace.go:172","msg":"trace[1159885491] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:781; }","duration":"316.379309ms","start":"2026-07-31T00:57:01.298482Z","end":"2026-07-31T00:57:01.614861Z","steps":["trace[1159885491] 'agreement among raft nodes before linearized reading' (duration: 316.303707ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:57:01.616341Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"311.527995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T00:57:01.616424Z","caller":"traceutil/trace.go:172","msg":"trace[1009267727] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:781; }","duration":"311.623668ms","start":"2026-07-31T00:57:01.304784Z","end":"2026-07-31T00:57:01.616408Z","steps":["trace[1009267727] 'agreement among raft nodes before linearized reading' (duration: 311.485434ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:57:01.616470Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:57:01.304760Z","time spent":"311.696781ms","remote":"127.0.0.1:43236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-31T00:57:01.616837Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"125.060157ms","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-07-31T00:57:01.616957Z","caller":"traceutil/trace.go:172","msg":"trace[1733230534] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:781; }","duration":"125.17798ms","start":"2026-07-31T00:57:01.491741Z","end":"2026-07-31T00:57:01.616919Z","steps":["trace[1733230534] 'agreement among raft nodes before linearized reading' (duration: 124.911781ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:57:02.799097Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12834871590681433585,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-31T00:57:02.925222Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"239.292593ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-31T00:57:02.925575Z","caller":"traceutil/trace.go:172","msg":"trace[659016105] linearizableReadLoop","detail":"{readStateIndex:860; appliedIndex:858; }","duration":"627.085543ms","start":"2026-07-31T00:57:02.298461Z","end":"2026-07-31T00:57:02.925546Z","steps":["trace[659016105] 'read index received' (duration: 626.04876ms)","trace[659016105] 'applied index is now lower than readState.Index' (duration: 1.034813ms)"],"step_count":2} {"level":"warn","ts":"2026-07-31T00:57:02.925721Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"627.248538ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T00:57:02.925753Z","caller":"traceutil/trace.go:172","msg":"trace[1026876257] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:789; }","duration":"627.29367ms","start":"2026-07-31T00:57:02.298449Z","end":"2026-07-31T00:57:02.925743Z","steps":["trace[1026876257] 'agreement among raft nodes before linearized reading' (duration: 627.219227ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:57:03.040101Z","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":12834871590681433586,"received-request-id":12834871590681433585} {"level":"info","ts":"2026-07-31T00:57:03.051971Z","caller":"traceutil/trace.go:172","msg":"trace[1511348163] linearizableReadLoop","detail":"{readStateIndex:877; appliedIndex:875; }","duration":"126.303231ms","start":"2026-07-31T00:57:02.925643Z","end":"2026-07-31T00:57:03.051946Z","steps":["trace[1511348163] 'read index received' (duration: 126.011992ms)","trace[1511348163] 'applied index is now lower than readState.Index' (duration: 290.249µs)"],"step_count":2} {"level":"warn","ts":"2026-07-31T00:57:03.052061Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"747.240958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T00:57:03.052083Z","caller":"traceutil/trace.go:172","msg":"trace[666167873] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:803; }","duration":"747.278049ms","start":"2026-07-31T00:57:02.304798Z","end":"2026-07-31T00:57:03.052076Z","steps":["trace[666167873] 'agreement among raft nodes before linearized reading' (duration: 747.220977ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:57:03.052106Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:57:02.304777Z","time spent":"747.324361ms","remote":"127.0.0.1:43236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-31T00:57:19.321085Z","caller":"traceutil/trace.go:172","msg":"trace[932104282] transaction","detail":"{read_only:false; number_of_response:1; response_revision:954; }","duration":"101.557147ms","start":"2026-07-31T00:57:19.219499Z","end":"2026-07-31T00:57:19.321056Z","steps":["trace[932104282] 'process raft request' (duration: 101.36769ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T00:57:19.334534Z","caller":"traceutil/trace.go:172","msg":"trace[196446186] transaction","detail":"{read_only:false; number_of_response:1; response_revision:956; }","duration":"104.435239ms","start":"2026-07-31T00:57:19.230054Z","end":"2026-07-31T00:57:19.334489Z","steps":["trace[196446186] 'process raft request' (duration: 104.214121ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:57:20.417779Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"119.515484ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T00:57:20.418026Z","caller":"traceutil/trace.go:172","msg":"trace[1614569447] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:977; }","duration":"119.786954ms","start":"2026-07-31T00:57:20.298217Z","end":"2026-07-31T00:57:20.418004Z","steps":["trace[1614569447] 'range keys from in-memory index tree' (duration: 119.453881ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T00:57:20.425275Z","caller":"traceutil/trace.go:172","msg":"trace[2135679037] transaction","detail":"{read_only:false; number_of_response:1; response_revision:977; }","duration":"600.232466ms","start":"2026-07-31T00:57:19.824983Z","end":"2026-07-31T00:57:20.425215Z","steps":["trace[2135679037] 'process raft request' (duration: 599.891784ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:57:20.425860Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:57:19.824933Z","time spent":"600.480745ms","remote":"127.0.0.1:43332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97,"response count":0,"response size":151272,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-31T00:57:20.448489Z","caller":"traceutil/trace.go:172","msg":"trace[1492881410] linearizableReadLoop","detail":"{readStateIndex:1145; appliedIndex:1145; }","duration":"380.818952ms","start":"2026-07-31T00:57:20.067620Z","end":"2026-07-31T00:57:20.448439Z","steps":["trace[1492881410] 'read index received' (duration: 380.803331ms)","trace[1492881410] 'applied index is now lower than readState.Index' (duration: 13.65µs)"],"step_count":2} {"level":"warn","ts":"2026-07-31T00:57:20.448656Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"381.023649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:442"} {"level":"info","ts":"2026-07-31T00:57:20.448664Z","caller":"traceutil/trace.go:172","msg":"trace[1011014019] transaction","detail":"{read_only:false; number_of_response:1; response_revision:982; }","duration":"610.138535ms","start":"2026-07-31T00:57:19.838503Z","end":"2026-07-31T00:57:20.448642Z","steps":["trace[1011014019] 'process raft request' (duration: 610.044131ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T00:57:20.448732Z","caller":"traceutil/trace.go:172","msg":"trace[5084549] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:982; }","duration":"381.117263ms","start":"2026-07-31T00:57:20.067601Z","end":"2026-07-31T00:57:20.448718Z","steps":["trace[5084549] 'agreement among raft nodes before linearized reading' (duration: 380.987898ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:57:20.448804Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:57:20.067566Z","time spent":"381.229486ms","remote":"127.0.0.1:43730","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-07-31T00:57:20.448827Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:57:19.838464Z","time spent":"610.28159ms","remote":"127.0.0.1:43332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":101,"response count":0,"response size":20893,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-31T00:57:20.467014Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"283.548159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.38\" limit:1 ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-07-31T00:57:20.467148Z","caller":"traceutil/trace.go:172","msg":"trace[2055652514] range","detail":"{range_begin:/registry/masterleases/199.204.45.38; range_end:; response_count:1; response_revision:983; }","duration":"283.701434ms","start":"2026-07-31T00:57:20.183418Z","end":"2026-07-31T00:57:20.467120Z","steps":["trace[2055652514] 'agreement among raft nodes before linearized reading' (duration: 283.325711ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T00:57:21.141498Z","caller":"traceutil/trace.go:172","msg":"trace[1530526972] transaction","detail":"{read_only:false; number_of_response:1; response_revision:990; }","duration":"482.659083ms","start":"2026-07-31T00:57:20.658821Z","end":"2026-07-31T00:57:21.141480Z","steps":["trace[1530526972] 'process raft request' (duration: 482.366673ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:57:21.141694Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:57:20.658776Z","time spent":"482.797359ms","remote":"127.0.0.1:43332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":95,"response count":0,"response size":570132,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-31T00:57:26.425931Z","caller":"traceutil/trace.go:172","msg":"trace[728570753] linearizableReadLoop","detail":"{readStateIndex:1202; appliedIndex:1202; }","duration":"127.034687ms","start":"2026-07-31T00:57:26.298862Z","end":"2026-07-31T00:57:26.425897Z","steps":["trace[728570753] 'read index received' (duration: 127.027127ms)","trace[728570753] 'applied index is now lower than readState.Index' (duration: 5.61µs)"],"step_count":2} {"level":"warn","ts":"2026-07-31T00:57:26.426127Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"127.300788ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T00:57:26.426231Z","caller":"traceutil/trace.go:172","msg":"trace[1032367216] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1026; }","duration":"127.430062ms","start":"2026-07-31T00:57:26.298775Z","end":"2026-07-31T00:57:26.426205Z","steps":["trace[1032367216] 'agreement among raft nodes before linearized reading' (duration: 127.267976ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:57:26.427446Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"123.6029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T00:57:26.427526Z","caller":"traceutil/trace.go:172","msg":"trace[1405579425] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1026; }","duration":"123.680932ms","start":"2026-07-31T00:57:26.303832Z","end":"2026-07-31T00:57:26.427513Z","steps":["trace[1405579425] 'agreement among raft nodes before linearized reading' (duration: 123.580939ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:57:27.807484Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12834871590681433752,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-31T00:57:28.308375Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12834871590681433752,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-31T00:57:28.809006Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12834871590681433752,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-31T00:57:29.081456Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.42631207s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"warn","ts":"2026-07-31T00:57:29.080835Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.783284359s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T00:57:29.081640Z","caller":"traceutil/trace.go:172","msg":"trace[1686941113] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1035; }","duration":"1.78411571s","start":"2026-07-31T00:57:27.297496Z","end":"2026-07-31T00:57:29.081612Z","steps":["trace[1686941113] 'range keys from in-memory index tree' (duration: 1.783214966s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:57:29.308140Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.000873656s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-31T00:57:29.308251Z","caller":"traceutil/trace.go:172","msg":"trace[1483656538] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.001635895s","start":"2026-07-31T00:57:27.306592Z","end":"2026-07-31T00:57:29.308228Z","steps":["trace[1483656538] 'agreement among raft nodes before linearized reading' (duration: 2.000870426s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:57:29.308317Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:57:27.306553Z","time spent":"2.0017514s","remote":"127.0.0.1:43236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/07/31 00:57:29 WARNING: [core] [Server #5]grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-31T00:57:29.309183Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12834871590681433752,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-31T00:57:29.809499Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12834871590681433752,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-31T00:57:30.309873Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12834871590681433752,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-31T00:57:30.629532Z","caller":"wal/wal.go:845","msg":"slow fdatasync","took":"1.93411432s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-31T00:57:30.658548Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.576085216s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-31T00:57:30.758919Z","caller":"traceutil/trace.go:172","msg":"trace[1737527230] linearizableReadLoop","detail":"{readStateIndex:1227; appliedIndex:1224; }","duration":"3.452232853s","start":"2026-07-31T00:57:27.306612Z","end":"2026-07-31T00:57:30.758845Z","steps":["trace[1737527230] 'read index received' (duration: 3.323189272s)","trace[1737527230] 'applied index is now lower than readState.Index' (duration: 129.035771ms)"],"step_count":2} {"level":"info","ts":"2026-07-31T00:57:30.759029Z","caller":"traceutil/trace.go:172","msg":"trace[1604457987] transaction","detail":"{read_only:false; response_revision:1053; number_of_response:1; }","duration":"3.388246176s","start":"2026-07-31T00:57:27.370749Z","end":"2026-07-31T00:57:30.758995Z","steps":["trace[1604457987] 'process raft request' (duration: 3.388125492s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:57:30.759217Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:57:27.370710Z","time spent":"3.388412672s","remote":"127.0.0.1:43730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":537,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-31T00:57:31.259584Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12834871590681433755,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-31T00:57:31.309889Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.000434529s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-31T00:57:31.310235Z","caller":"traceutil/trace.go:172","msg":"trace[200712351] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000591625s","start":"2026-07-31T00:57:29.309421Z","end":"2026-07-31T00:57:31.310013Z","steps":["trace[200712351] 'agreement among raft nodes before linearized reading' (duration: 2.000432119s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:57:31.310431Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:57:29.309386Z","time spent":"2.001031521s","remote":"127.0.0.1:43222","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-07-31T00:57:31.396785Z","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":12834871590681433755,"received-request-id":12834871590681433752} {"level":"warn","ts":"2026-07-31T00:57:31.463833Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"175.414325ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-31T00:57:31.523057Z","caller":"traceutil/trace.go:172","msg":"trace[57317787] transaction","detail":"{read_only:false; response_revision:1062; number_of_response:1; }","duration":"1.97120201s","start":"2026-07-31T00:57:29.551820Z","end":"2026-07-31T00:57:31.523022Z","steps":["trace[57317787] 'process raft request' (duration: 1.970981252s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:57:31.523359Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:57:29.551773Z","time spent":"1.971418468s","remote":"127.0.0.1:43730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":677,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-31T00:57:31.613764Z","caller":"traceutil/trace.go:172","msg":"trace[1856105765] linearizableReadLoop","detail":"{readStateIndex:1239; appliedIndex:1240; }","duration":"854.665823ms","start":"2026-07-31T00:57:30.759072Z","end":"2026-07-31T00:57:31.613738Z","steps":["trace[1856105765] 'read index received' (duration: 854.655243ms)","trace[1856105765] 'applied index is now lower than readState.Index' (duration: 9.17µs)"],"step_count":2} {"level":"warn","ts":"2026-07-31T00:57:31.636221Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.452520004s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.38\" limit:1 ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-07-31T00:57:31.636303Z","caller":"traceutil/trace.go:172","msg":"trace[12576604] range","detail":"{range_begin:/registry/masterleases/199.204.45.38; range_end:; response_count:1; response_revision:1062; }","duration":"1.452623668s","start":"2026-07-31T00:57:30.183661Z","end":"2026-07-31T00:57:31.636285Z","steps":["trace[12576604] 'agreement among raft nodes before linearized reading' (duration: 1.430216857s)","trace[12576604] 'range keys from in-memory index tree' (duration: 22.162443ms)"],"step_count":2} {"level":"warn","ts":"2026-07-31T00:57:31.636360Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:57:30.183636Z","time spent":"1.452714602s","remote":"127.0.0.1:43288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.38\" limit:1 "} {"level":"warn","ts":"2026-07-31T00:57:31.636411Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"4.302523149s","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-07-31T00:57:31.636477Z","caller":"traceutil/trace.go:172","msg":"trace[2042284010] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1062; }","duration":"4.302796119s","start":"2026-07-31T00:57:27.333664Z","end":"2026-07-31T00:57:31.636460Z","steps":["trace[2042284010] 'agreement among raft nodes before linearized reading' (duration: 4.280257382s)","trace[2042284010] 'range keys from in-memory index tree' (duration: 22.213954ms)"],"step_count":2} {"level":"warn","ts":"2026-07-31T00:57:31.636510Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:57:27.333637Z","time spent":"4.302866171s","remote":"127.0.0.1:43730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" limit:1 "} {"level":"warn","ts":"2026-07-31T00:57:31.636741Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.512154781s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" limit:1 ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-31T00:57:31.636765Z","caller":"traceutil/trace.go:172","msg":"trace[1646987812] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1062; }","duration":"2.512178512s","start":"2026-07-31T00:57:29.124577Z","end":"2026-07-31T00:57:31.636756Z","steps":["trace[1646987812] 'agreement among raft nodes before linearized reading' (duration: 2.489319512s)","trace[1646987812] 'range keys from in-memory index tree' (duration: 22.816178ms)"],"step_count":2} {"level":"warn","ts":"2026-07-31T00:57:31.636789Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:57:29.124528Z","time spent":"2.512249905s","remote":"127.0.0.1:43730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" limit:1 "} {"level":"warn","ts":"2026-07-31T00:57:31.637837Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"3.359863039s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:442"} {"level":"info","ts":"2026-07-31T00:57:31.637899Z","caller":"traceutil/trace.go:172","msg":"trace[808062091] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1062; }","duration":"3.359921781s","start":"2026-07-31T00:57:28.277960Z","end":"2026-07-31T00:57:31.637882Z","steps":["trace[808062091] 'agreement among raft nodes before linearized reading' (duration: 3.33595616s)","trace[808062091] 'range keys from in-memory index tree' (duration: 23.843367ms)"],"step_count":2} {"level":"warn","ts":"2026-07-31T00:57:31.637934Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:57:28.277942Z","time spent":"3.359980084s","remote":"127.0.0.1:43730","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-07-31T00:57:31.638040Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"3.680890966s","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-07-31T00:57:31.638157Z","caller":"traceutil/trace.go:172","msg":"trace[1912007014] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1062; }","duration":"3.681044992s","start":"2026-07-31T00:57:27.957099Z","end":"2026-07-31T00:57:31.638144Z","steps":["trace[1912007014] 'agreement among raft nodes before linearized reading' (duration: 3.656809181s)","trace[1912007014] 'range keys from in-memory index tree' (duration: 23.66549ms)"],"step_count":2} {"level":"warn","ts":"2026-07-31T00:57:31.638230Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"2.556524383s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T00:57:31.638292Z","caller":"traceutil/trace.go:172","msg":"trace[709180728] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1062; }","duration":"2.556591015s","start":"2026-07-31T00:57:29.081686Z","end":"2026-07-31T00:57:31.638277Z","steps":["trace[709180728] 'agreement among raft nodes before linearized reading' (duration: 2.532093714s)","trace[709180728] 'range keys from in-memory index tree' (duration: 24.298783ms)"],"step_count":2} {"level":"warn","ts":"2026-07-31T00:57:31.638076Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"3.997341453s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-srb8x\" limit:1 ","response":"range_response_count:1 size:18349"} {"level":"info","ts":"2026-07-31T00:57:31.638586Z","caller":"traceutil/trace.go:172","msg":"trace[488917503] range","detail":"{range_begin:/registry/pods/kube-system/cilium-srb8x; range_end:; response_count:1; response_revision:1062; }","duration":"3.997843972s","start":"2026-07-31T00:57:27.640726Z","end":"2026-07-31T00:57:31.638570Z","steps":["trace[488917503] 'agreement among raft nodes before linearized reading' (duration: 3.973182645s)","trace[488917503] 'range keys from in-memory index tree' (duration: 24.104937ms)"],"step_count":2} {"level":"warn","ts":"2026-07-31T00:57:31.638635Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:57:27.640694Z","time spent":"3.997920665s","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":18372,"request content":"key:\"/registry/pods/kube-system/cilium-srb8x\" limit:1 "} {"level":"warn","ts":"2026-07-31T00:57:31.639441Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:57:27.957070Z","time spent":"3.681192308s","remote":"127.0.0.1:43730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 "} {"level":"info","ts":"2026-07-31T00:57:31.641130Z","caller":"traceutil/trace.go:172","msg":"trace[734751083] transaction","detail":"{read_only:false; response_revision:1066; number_of_response:1; }","duration":"321.941193ms","start":"2026-07-31T00:57:31.319174Z","end":"2026-07-31T00:57:31.641115Z","steps":["trace[734751083] 'process raft request' (duration: 320.53484ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:57:31.641226Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:57:31.319160Z","time spent":"322.014976ms","remote":"127.0.0.1:43384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":779,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-31T00:57:31.726404Z","caller":"traceutil/trace.go:172","msg":"trace[858115807] linearizableReadLoop","detail":"{readStateIndex:1245; appliedIndex:1247; }","duration":"112.489296ms","start":"2026-07-31T00:57:31.613888Z","end":"2026-07-31T00:57:31.726377Z","steps":["trace[858115807] 'read index received' (duration: 112.478695ms)","trace[858115807] 'applied index is now lower than readState.Index' (duration: 8.71µs)"],"step_count":2} {"level":"warn","ts":"2026-07-31T00:57:31.726508Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"404.009202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-31T00:57:31.726544Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"409.357815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T00:57:31.726582Z","caller":"traceutil/trace.go:172","msg":"trace[1851294412] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1068; }","duration":"404.099716ms","start":"2026-07-31T00:57:31.322466Z","end":"2026-07-31T00:57:31.726565Z","steps":["trace[1851294412] 'agreement among raft nodes before linearized reading' (duration: 403.95604ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T00:57:31.726606Z","caller":"traceutil/trace.go:172","msg":"trace[461803060] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1068; }","duration":"409.449339ms","start":"2026-07-31T00:57:31.317145Z","end":"2026-07-31T00:57:31.726595Z","steps":["trace[461803060] 'agreement among raft nodes before linearized reading' (duration: 409.327274ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:57:31.726628Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:57:31.322457Z","time spent":"404.161839ms","remote":"127.0.0.1:43222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-31T00:57:31.726641Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:57:31.317085Z","time spent":"409.550183ms","remote":"127.0.0.1:43236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-31T00:57:31.908601Z","caller":"traceutil/trace.go:172","msg":"trace[640192559] transaction","detail":"{read_only:false; response_revision:1069; number_of_response:1; }","duration":"254.637096ms","start":"2026-07-31T00:57:31.653936Z","end":"2026-07-31T00:57:31.908573Z","steps":["trace[640192559] 'process raft request' (duration: 254.441568ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T00:57:31.909470Z","caller":"traceutil/trace.go:172","msg":"trace[2087357549] linearizableReadLoop","detail":"{readStateIndex:1247; appliedIndex:1248; }","duration":"182.947491ms","start":"2026-07-31T00:57:31.726492Z","end":"2026-07-31T00:57:31.909439Z","steps":["trace[2087357549] 'read index received' (duration: 182.938751ms)","trace[2087357549] 'applied index is now lower than readState.Index' (duration: 6.91µs)"],"step_count":2} {"level":"warn","ts":"2026-07-31T00:57:31.909628Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"269.48749ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T00:57:31.909668Z","caller":"traceutil/trace.go:172","msg":"trace[1013556176] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1069; }","duration":"269.554162ms","start":"2026-07-31T00:57:31.640103Z","end":"2026-07-31T00:57:31.909657Z","steps":["trace[1013556176] 'agreement among raft nodes before linearized reading' (duration: 269.447338ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T00:57:31.995663Z","caller":"traceutil/trace.go:172","msg":"trace[1651800544] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"268.902078ms","start":"2026-07-31T00:57:31.726737Z","end":"2026-07-31T00:57:31.995639Z","steps":["trace[1651800544] 'process raft request' (duration: 268.794124ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T00:57:31.995854Z","caller":"traceutil/trace.go:172","msg":"trace[1948508830] transaction","detail":"{read_only:false; response_revision:1070; number_of_response:1; }","duration":"287.510196ms","start":"2026-07-31T00:57:31.708309Z","end":"2026-07-31T00:57:31.995819Z","steps":["trace[1948508830] 'process raft request' (duration: 284.544373ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:57:32.122410Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"121.269627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" limit:1 ","response":"range_response_count:1 size:460"} {"level":"info","ts":"2026-07-31T00:57:32.122528Z","caller":"traceutil/trace.go:172","msg":"trace[7771093] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1075; }","duration":"121.411562ms","start":"2026-07-31T00:57:32.001088Z","end":"2026-07-31T00:57:32.122500Z","steps":["trace[7771093] 'agreement among raft nodes before linearized reading' (duration: 94.89365ms)","trace[7771093] 'range keys from in-memory index tree' (duration: 26.18248ms)"],"step_count":2} {"level":"info","ts":"2026-07-31T00:57:32.123218Z","caller":"traceutil/trace.go:172","msg":"trace[1553506585] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"109.943195ms","start":"2026-07-31T00:57:32.013249Z","end":"2026-07-31T00:57:32.123192Z","steps":["trace[1553506585] 'process raft request' (duration: 109.784569ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:57:32.124842Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"122.926761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-controller-3.18c739e9449f2f9c\" limit:1 ","response":"range_response_count:1 size:794"} {"level":"info","ts":"2026-07-31T00:57:32.124930Z","caller":"traceutil/trace.go:172","msg":"trace[62659505] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-controller-3.18c739e9449f2f9c; range_end:; response_count:1; response_revision:1078; }","duration":"123.034876ms","start":"2026-07-31T00:57:32.001880Z","end":"2026-07-31T00:57:32.124915Z","steps":["trace[62659505] 'agreement among raft nodes before linearized reading' (duration: 122.804677ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T00:57:34.180441Z","caller":"traceutil/trace.go:172","msg":"trace[1310767560] linearizableReadLoop","detail":"{readStateIndex:1297; appliedIndex:1297; }","duration":"139.058252ms","start":"2026-07-31T00:57:34.041327Z","end":"2026-07-31T00:57:34.180386Z","steps":["trace[1310767560] 'read index received' (duration: 139.051192ms)","trace[1310767560] 'applied index is now lower than readState.Index' (duration: 6.58µs)"],"step_count":2} {"level":"warn","ts":"2026-07-31T00:57:34.180615Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"139.280021ms","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-07-31T00:57:34.180640Z","caller":"traceutil/trace.go:172","msg":"trace[1558025863] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1116; }","duration":"139.329652ms","start":"2026-07-31T00:57:34.041303Z","end":"2026-07-31T00:57:34.180633Z","steps":["trace[1558025863] 'agreement among raft nodes before linearized reading' (duration: 139.199487ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T00:57:40.801700Z","caller":"traceutil/trace.go:172","msg":"trace[2049869223] linearizableReadLoop","detail":"{readStateIndex:1435; appliedIndex:1435; }","duration":"427.250728ms","start":"2026-07-31T00:57:40.374418Z","end":"2026-07-31T00:57:40.801669Z","steps":["trace[2049869223] 'read index received' (duration: 427.239388ms)","trace[2049869223] 'applied index is now lower than readState.Index' (duration: 9.75µs)"],"step_count":2} {"level":"warn","ts":"2026-07-31T00:57:40.801983Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"427.54585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:496"} {"level":"info","ts":"2026-07-31T00:57:40.802150Z","caller":"traceutil/trace.go:172","msg":"trace[367003098] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1215; }","duration":"427.728147ms","start":"2026-07-31T00:57:40.374398Z","end":"2026-07-31T00:57:40.802127Z","steps":["trace[367003098] 'agreement among raft nodes before linearized reading' (duration: 427.375233ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:57:40.802221Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:57:40.374326Z","time spent":"427.878803ms","remote":"127.0.0.1:43730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":519,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 "} {"level":"info","ts":"2026-07-31T00:57:40.803965Z","caller":"traceutil/trace.go:172","msg":"trace[1036945652] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1215; }","duration":"421.878837ms","start":"2026-07-31T00:57:40.382071Z","end":"2026-07-31T00:57:40.803950Z","steps":["trace[1036945652] 'process raft request' (duration: 421.767773ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:57:40.804095Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:57:40.382041Z","time spent":"421.971412ms","remote":"127.0.0.1:43332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":86,"response count":0,"response size":13254,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-31T00:57:40.805518Z","caller":"traceutil/trace.go:172","msg":"trace[603879223] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1218; }","duration":"379.281359ms","start":"2026-07-31T00:57:40.426216Z","end":"2026-07-31T00:57:40.805497Z","steps":["trace[603879223] 'process raft request' (duration: 379.240597ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:57:40.805682Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:57:40.426184Z","time spent":"379.399524ms","remote":"127.0.0.1:43332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":86,"response count":0,"response size":13263,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-31T00:57:52.798746Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12834871590681434015,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-31T00:57:52.847779Z","caller":"traceutil/trace.go:172","msg":"trace[570248123] linearizableReadLoop","detail":"{readStateIndex:1595; appliedIndex:1595; }","duration":"549.411136ms","start":"2026-07-31T00:57:52.298314Z","end":"2026-07-31T00:57:52.847725Z","steps":["trace[570248123] 'read index received' (duration: 549.405376ms)","trace[570248123] 'applied index is now lower than readState.Index' (duration: 4.94µs)"],"step_count":2} {"level":"warn","ts":"2026-07-31T00:57:52.847973Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"549.630675ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T00:57:52.848097Z","caller":"traceutil/trace.go:172","msg":"trace[372223283] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1353; }","duration":"549.781301ms","start":"2026-07-31T00:57:52.298299Z","end":"2026-07-31T00:57:52.848080Z","steps":["trace[372223283] 'agreement among raft nodes before linearized reading' (duration: 549.598834ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:58:00.270430Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48560","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:58:00.292994Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48594","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:58:00.308157Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48612","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:58:00.398258Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48628","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:58:00.481709Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48660","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:58:00.551423Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48670","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:58:00.599885Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48686","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:58:00.640189Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48714","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:58:00.666871Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48726","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:58:00.698140Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48744","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:58:00.854488Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48764","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:58:00.883664Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48786","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:58:00.900942Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48796","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:58:00.925125Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48830","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:58:00.974662Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48852","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:58:01.068407Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48860","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:58:01.089969Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48868","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:58:01.106928Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48876","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:58:02.172396Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48892","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:58:02.183088Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48900","server-name":"","error":"EOF"} {"level":"warn","ts":"2026-07-31T00:58:03.368698Z","caller":"embed/config_logging.go:188","msg":"rejected connection on client endpoint","remote-addr":"127.0.0.1:48918","server-name":"","error":"EOF"} {"level":"info","ts":"2026-07-31T00:58:20.147340Z","caller":"traceutil/trace.go:172","msg":"trace[53369600] linearizableReadLoop","detail":"{readStateIndex:1765; appliedIndex:1765; }","duration":"364.32759ms","start":"2026-07-31T00:58:19.782969Z","end":"2026-07-31T00:58:20.147297Z","steps":["trace[53369600] 'read index received' (duration: 364.31787ms)","trace[53369600] 'applied index is now lower than readState.Index' (duration: 8.08µs)"],"step_count":2} {"level":"warn","ts":"2026-07-31T00:58:20.149020Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"366.050967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" keys_only:true ","response":"range_response_count:180 size:15479"} {"level":"info","ts":"2026-07-31T00:58:20.149113Z","caller":"traceutil/trace.go:172","msg":"trace[1948422670] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:180; response_revision:1507; }","duration":"366.159351ms","start":"2026-07-31T00:58:19.782937Z","end":"2026-07-31T00:58:20.149096Z","steps":["trace[1948422670] 'agreement among raft nodes before linearized reading' (duration: 364.477777ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:58:20.149160Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:58:19.782907Z","time spent":"366.239724ms","remote":"127.0.0.1:44298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":180,"response size":15502,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" keys_only:true "} {"level":"warn","ts":"2026-07-31T00:58:20.647640Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12834871590681434283,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-31T00:58:21.147810Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12834871590681434283,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-31T00:58:21.648715Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12834871590681434283,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-31T00:58:21.696534Z","caller":"traceutil/trace.go:172","msg":"trace[804413881] transaction","detail":"{read_only:false; response_revision:1509; number_of_response:1; }","duration":"1.372388144s","start":"2026-07-31T00:58:20.324119Z","end":"2026-07-31T00:58:21.696507Z","steps":["trace[804413881] 'process raft request' (duration: 1.372230458s)"],"step_count":1} {"level":"info","ts":"2026-07-31T00:58:21.696612Z","caller":"traceutil/trace.go:172","msg":"trace[1319257117] linearizableReadLoop","detail":"{readStateIndex:1765; appliedIndex:1766; }","duration":"1.54909468s","start":"2026-07-31T00:58:20.147492Z","end":"2026-07-31T00:58:21.696587Z","steps":["trace[1319257117] 'read index received' (duration: 1.548852769s)","trace[1319257117] 'applied index is now lower than readState.Index' (duration: 7.751µs)"],"step_count":2} {"level":"warn","ts":"2026-07-31T00:58:21.696665Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.832354557s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" limit:1 ","response":"range_response_count:1 size:442"} {"level":"info","ts":"2026-07-31T00:58:21.696725Z","caller":"traceutil/trace.go:172","msg":"trace[1224873479] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1510; }","duration":"1.83242828s","start":"2026-07-31T00:58:19.864278Z","end":"2026-07-31T00:58:21.696707Z","steps":["trace[1224873479] 'agreement among raft nodes before linearized reading' (duration: 1.83218403s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:58:21.696770Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:58:19.864243Z","time spent":"1.832514524s","remote":"127.0.0.1:43730","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-07-31T00:58:21.696782Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:58:20.324078Z","time spent":"1.372577843s","remote":"127.0.0.1:43730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-31T00:58:21.698922Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"804.999922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-07-31T00:58:21.698930Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.391784132s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T00:58:21.699004Z","caller":"traceutil/trace.go:172","msg":"trace[443905560] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1511; }","duration":"805.083486ms","start":"2026-07-31T00:58:20.893900Z","end":"2026-07-31T00:58:21.698984Z","steps":["trace[443905560] 'agreement among raft nodes before linearized reading' (duration: 804.94348ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T00:58:21.699013Z","caller":"traceutil/trace.go:172","msg":"trace[1823779212] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1511; }","duration":"1.391895877s","start":"2026-07-31T00:58:20.307103Z","end":"2026-07-31T00:58:21.698999Z","steps":["trace[1823779212] 'agreement among raft nodes before linearized reading' (duration: 1.39175527s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:58:21.699047Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:58:20.307048Z","time spent":"1.39199409s","remote":"127.0.0.1:43236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-31T00:58:21.699050Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:58:20.893872Z","time spent":"805.164709ms","remote":"127.0.0.1:43730","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-07-31T00:58:21.699060Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"545.014649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:495"} {"level":"warn","ts":"2026-07-31T00:58:21.699113Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.40090245s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T00:58:21.699131Z","caller":"traceutil/trace.go:172","msg":"trace[955607068] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1511; }","duration":"545.084482ms","start":"2026-07-31T00:58:21.154025Z","end":"2026-07-31T00:58:21.699109Z","steps":["trace[955607068] 'agreement among raft nodes before linearized reading' (duration: 544.886294ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T00:58:21.699159Z","caller":"traceutil/trace.go:172","msg":"trace[554809766] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1511; }","duration":"1.400951182s","start":"2026-07-31T00:58:20.298195Z","end":"2026-07-31T00:58:21.699146Z","steps":["trace[554809766] 'agreement among raft nodes before linearized reading' (duration: 1.400879879s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:58:21.699167Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:58:21.153996Z","time spent":"545.163515ms","remote":"127.0.0.1:43730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 "} {"level":"warn","ts":"2026-07-31T00:58:21.699280Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"604.546053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingadmissionpolicybindings\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-31T00:58:21.699388Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.512751964s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-31T00:58:21.699693Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"383.706093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T00:58:21.699823Z","caller":"traceutil/trace.go:172","msg":"trace[732765201] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1511; }","duration":"384.54444ms","start":"2026-07-31T00:58:21.315263Z","end":"2026-07-31T00:58:21.699807Z","steps":["trace[732765201] 'agreement among raft nodes before linearized reading' (duration: 383.671262ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:58:21.699969Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:58:21.315229Z","time spent":"384.728817ms","remote":"127.0.0.1:43236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-31T00:58:21.699943Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.349798438s","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-07-31T00:58:21.700758Z","caller":"traceutil/trace.go:172","msg":"trace[661170120] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1511; }","duration":"1.350614644s","start":"2026-07-31T00:58:20.350126Z","end":"2026-07-31T00:58:21.700741Z","steps":["trace[661170120] 'agreement among raft nodes before linearized reading' (duration: 1.348866558s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:58:21.700823Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:58:20.350068Z","time spent":"1.350719078s","remote":"127.0.0.1:43730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" limit:1 "} {"level":"warn","ts":"2026-07-31T00:58:21.700898Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.514367104s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.38\" limit:1 ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-07-31T00:58:21.699607Z","caller":"traceutil/trace.go:172","msg":"trace[1889198630] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions; range_end:; response_count:0; response_revision:1511; }","duration":"1.512887119s","start":"2026-07-31T00:58:20.186616Z","end":"2026-07-31T00:58:21.699503Z","steps":["trace[1889198630] 'agreement among raft nodes before linearized reading' (duration: 1.512638739s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:58:21.701066Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:58:20.186589Z","time spent":"1.514463838s","remote":"127.0.0.1:43332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions\" limit:1 "} {"level":"info","ts":"2026-07-31T00:58:21.700991Z","caller":"traceutil/trace.go:172","msg":"trace[1642585256] range","detail":"{range_begin:/registry/masterleases/199.204.45.38; range_end:; response_count:1; response_revision:1511; }","duration":"1.514461288s","start":"2026-07-31T00:58:20.186518Z","end":"2026-07-31T00:58:21.700979Z","steps":["trace[1642585256] 'agreement among raft nodes before linearized reading' (duration: 1.512320865s)"],"step_count":1} {"level":"info","ts":"2026-07-31T00:58:21.701280Z","caller":"traceutil/trace.go:172","msg":"trace[522681822] range","detail":"{range_begin:/registry/validatingadmissionpolicybindings; range_end:; response_count:0; response_revision:1511; }","duration":"604.616716ms","start":"2026-07-31T00:58:21.094714Z","end":"2026-07-31T00:58:21.699331Z","steps":["trace[522681822] 'agreement among raft nodes before linearized reading' (duration: 604.478ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:58:21.701376Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:58:20.186488Z","time spent":"1.51473495s","remote":"127.0.0.1:43288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.38\" limit:1 "} {"level":"warn","ts":"2026-07-31T00:58:21.701318Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:58:21.094686Z","time spent":"606.619833ms","remote":"127.0.0.1:44280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":28,"request content":"key:\"/registry/validatingadmissionpolicybindings\" limit:1 "} {"level":"info","ts":"2026-07-31T00:58:24.096980Z","caller":"traceutil/trace.go:172","msg":"trace[1720715337] linearizableReadLoop","detail":"{readStateIndex:1778; appliedIndex:1779; }","duration":"380.57821ms","start":"2026-07-31T00:58:23.716379Z","end":"2026-07-31T00:58:24.096957Z","steps":["trace[1720715337] 'read index received' (duration: 380.571209ms)","trace[1720715337] 'applied index is now lower than readState.Index' (duration: 5.911µs)"],"step_count":2} {"level":"warn","ts":"2026-07-31T00:58:24.097251Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"380.849471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-07-31T00:58:24.097289Z","caller":"traceutil/trace.go:172","msg":"trace[361007193] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1520; }","duration":"380.903434ms","start":"2026-07-31T00:58:23.716373Z","end":"2026-07-31T00:58:24.097276Z","steps":["trace[361007193] 'agreement among raft nodes before linearized reading' (duration: 380.718466ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:58:24.097314Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:58:23.716357Z","time spent":"380.950916ms","remote":"127.0.0.1:43730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" limit:1 "} {"level":"info","ts":"2026-07-31T00:58:24.099277Z","caller":"traceutil/trace.go:172","msg":"trace[2123517859] transaction","detail":"{read_only:false; response_revision:1521; number_of_response:1; }","duration":"396.931458ms","start":"2026-07-31T00:58:23.702319Z","end":"2026-07-31T00:58:24.099251Z","steps":["trace[2123517859] 'process raft request' (duration: 396.770571ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:58:24.100298Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:58:23.702294Z","time spent":"397.085104ms","remote":"127.0.0.1:43730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-31T00:59:20.053206Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12834871590681434684,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-31T00:59:20.278441Z","caller":"traceutil/trace.go:172","msg":"trace[467436388] linearizableReadLoop","detail":"{readStateIndex:2033; appliedIndex:2033; }","duration":"726.169214ms","start":"2026-07-31T00:59:19.552238Z","end":"2026-07-31T00:59:20.278407Z","steps":["trace[467436388] 'read index received' (duration: 726.158913ms)","trace[467436388] 'applied index is now lower than readState.Index' (duration: 9.051µs)"],"step_count":2} {"level":"warn","ts":"2026-07-31T00:59:20.278627Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"726.390824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T00:59:20.278769Z","caller":"traceutil/trace.go:172","msg":"trace[586716507] range","detail":"{range_begin:/registry/statefulsets; range_end:; response_count:0; response_revision:1739; }","duration":"726.555162ms","start":"2026-07-31T00:59:19.552192Z","end":"2026-07-31T00:59:20.278747Z","steps":["trace[586716507] 'agreement among raft nodes before linearized reading' (duration: 726.320642ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:59:20.278828Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:59:19.552118Z","time spent":"726.699829ms","remote":"127.0.0.1:44144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":26,"response count":0,"response size":28,"request content":"key:\"/registry/statefulsets\" limit:1 "} {"level":"warn","ts":"2026-07-31T00:59:20.279881Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"194.359115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T00:59:20.279977Z","caller":"traceutil/trace.go:172","msg":"trace[1572269618] range","detail":"{range_begin:/registry/flowschemas; range_end:; response_count:0; response_revision:1739; }","duration":"194.47951ms","start":"2026-07-31T00:59:20.085480Z","end":"2026-07-31T00:59:20.279959Z","steps":["trace[1572269618] 'agreement among raft nodes before linearized reading' (duration: 194.309153ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:59:20.279972Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"298.161416ms","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-07-31T00:59:20.280020Z","caller":"traceutil/trace.go:172","msg":"trace[1272537981] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1739; }","duration":"298.222809ms","start":"2026-07-31T00:59:19.981786Z","end":"2026-07-31T00:59:20.280009Z","steps":["trace[1272537981] 'agreement among raft nodes before linearized reading' (duration: 297.999288ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T00:59:21.750820Z","caller":"traceutil/trace.go:172","msg":"trace[1495383580] linearizableReadLoop","detail":"{readStateIndex:2041; appliedIndex:2041; }","duration":"453.17722ms","start":"2026-07-31T00:59:21.297608Z","end":"2026-07-31T00:59:21.750785Z","steps":["trace[1495383580] 'read index received' (duration: 453.1694ms)","trace[1495383580] 'applied index is now lower than readState.Index' (duration: 6.28µs)"],"step_count":2} {"level":"warn","ts":"2026-07-31T00:59:21.751015Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"453.362868ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T00:59:21.751133Z","caller":"traceutil/trace.go:172","msg":"trace[1768774487] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1746; }","duration":"453.511455ms","start":"2026-07-31T00:59:21.297598Z","end":"2026-07-31T00:59:21.751110Z","steps":["trace[1768774487] 'agreement among raft nodes before linearized reading' (duration: 453.291675ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T00:59:22.066010Z","caller":"traceutil/trace.go:172","msg":"trace[154897974] linearizableReadLoop","detail":"{readStateIndex:2041; appliedIndex:2041; }","duration":"314.850885ms","start":"2026-07-31T00:59:21.751125Z","end":"2026-07-31T00:59:22.065976Z","steps":["trace[154897974] 'read index received' (duration: 314.845415ms)","trace[154897974] 'applied index is now lower than readState.Index' (duration: 4.84µs)"],"step_count":2} {"level":"warn","ts":"2026-07-31T00:59:22.066387Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"760.501795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T00:59:22.066505Z","caller":"traceutil/trace.go:172","msg":"trace[1404085727] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1746; }","duration":"760.633791ms","start":"2026-07-31T00:59:21.305850Z","end":"2026-07-31T00:59:22.066484Z","steps":["trace[1404085727] 'agreement among raft nodes before linearized reading' (duration: 760.40788ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:59:22.066556Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:59:21.305826Z","time spent":"760.721485ms","remote":"127.0.0.1:43236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-31T00:59:22.066419Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"512.705739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities\" limit:1 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T00:59:22.066652Z","caller":"traceutil/trace.go:172","msg":"trace[1110249534] range","detail":"{range_begin:/registry/csistoragecapacities; range_end:; response_count:0; response_revision:1746; }","duration":"512.960452ms","start":"2026-07-31T00:59:21.553669Z","end":"2026-07-31T00:59:22.066630Z","steps":["trace[1110249534] 'agreement among raft nodes before linearized reading' (duration: 512.642137ms)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:59:22.066753Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:59:21.553631Z","time spent":"513.105357ms","remote":"127.0.0.1:44080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/csistoragecapacities\" limit:1 "} {"level":"warn","ts":"2026-07-31T00:59:49.733127Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12834871590681434899,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-31T00:59:50.233593Z","caller":"etcdserver/v3_server.go:911","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12834871590681434899,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-31T00:59:50.333386Z","caller":"traceutil/trace.go:172","msg":"trace[848152645] linearizableReadLoop","detail":"{readStateIndex:2167; appliedIndex:2166; }","duration":"1.100861136s","start":"2026-07-31T00:59:49.232508Z","end":"2026-07-31T00:59:50.333369Z","steps":["trace[848152645] 'read index received' (duration: 1.10045217s)","trace[848152645] 'applied index is now lower than readState.Index' (duration: 408.306µs)"],"step_count":2} {"level":"info","ts":"2026-07-31T00:59:50.333485Z","caller":"traceutil/trace.go:172","msg":"trace[696596608] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"1.621990392s","start":"2026-07-31T00:59:48.711487Z","end":"2026-07-31T00:59:50.333478Z","steps":["trace[696596608] 'process raft request' (duration: 1.621711895s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:59:50.333604Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:59:48.711449Z","time spent":"1.622060131s","remote":"127.0.0.1:43730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":481,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-31T00:59:50.333653Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.101136424s","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-07-31T00:59:50.333725Z","caller":"traceutil/trace.go:172","msg":"trace[1352577995] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1855; }","duration":"1.101218413s","start":"2026-07-31T00:59:49.232489Z","end":"2026-07-31T00:59:50.333707Z","steps":["trace[1352577995] 'agreement among raft nodes before linearized reading' (duration: 1.101003625s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:59:50.333770Z","caller":"v3rpc/interceptor.go:202","msg":"request stats","start time":"2026-07-31T00:59:49.232460Z","time spent":"1.101296043s","remote":"127.0.0.1:43730","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-07-31T00:59:50.338193Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"1.04050715s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-31T00:59:50.338248Z","caller":"traceutil/trace.go:172","msg":"trace[2009110175] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1856; }","duration":"1.040564679s","start":"2026-07-31T00:59:49.297671Z","end":"2026-07-31T00:59:50.338236Z","steps":["trace[2009110175] 'agreement among raft nodes before linearized reading' (duration: 1.04048718s)"],"step_count":1} {"level":"warn","ts":"2026-07-31T00:59:50.338513Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"222.036735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" limit:1 ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-07-31T00:59:50.338547Z","caller":"txn/util.go:93","msg":"apply request took too long","took":"148.029694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.38\" limit:1 ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-07-31T00:59:50.338927Z","caller":"traceutil/trace.go:172","msg":"trace[315822463] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1856; }","duration":"222.405802ms","start":"2026-07-31T00:59:50.116406Z","end":"2026-07-31T00:59:50.338812Z","steps":["trace[315822463] 'agreement among raft nodes before linearized reading' (duration: 221.879357ms)"],"step_count":1} {"level":"info","ts":"2026-07-31T00:59:50.338915Z","caller":"traceutil/trace.go:172","msg":"trace[1108696971] range","detail":"{range_begin:/registry/masterleases/199.204.45.38; range_end:; response_count:1; response_revision:1856; }","duration":"148.396991ms","start":"2026-07-31T00:59:50.190506Z","end":"2026-07-31T00:59:50.338903Z","steps":["trace[1108696971] 'agreement among raft nodes before linearized reading' (duration: 147.735607ms)"],"step_count":1}